[58.165186] Initializing watchdogs
[58.165249]   /dev/watchdog0
[58.180117] [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]
[58.184672] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.186839] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.190044] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[58.329620] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[58.333790] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[58.417229] [002/133] (960s left) gem_eio (create-ext)
[58.549035] Starting subtest: create-ext
[58.707312] Subtest create-ext: SUCCESS (0.158s)
[58.841379] [003/133] (959s left) kms_vblank (query-forked-busy-hang)
[58.929731] Starting subtest: query-forked-busy-hang
[58.932388] Starting dynamic subtest: pipe-A-eDP-1
[60.838900] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.921s)
[60.853361] Starting dynamic subtest: pipe-D-eDP-1
[63.385802] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[63.388301] Subtest query-forked-busy-hang: SUCCESS (4.481s)
[64.176306] [004/133] (954s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[64.281624] Starting subtest: plane-use-after-nonblocking-unbind
[64.283945] Starting dynamic subtest: pipe-A-eDP-1
[64.338707] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[64.644597] Starting dynamic subtest: pipe-B-eDP-1
[65.470986] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.836s)
[65.784478] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.508s)
[66.627749] [005/133] (952s left) vgem_basic (dmabuf-export)
[66.696748] Starting subtest: dmabuf-export
[66.724246] Subtest dmabuf-export: SUCCESS (0.030s)
[66.819688] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true
[66.822769] [006/133] (952s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[66.913744] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[66.918242] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[67.007297] [007/133] (951s left) gen9_exec_parse (allowed-single)
[67.067965] Subtest allowed-single: SKIP (0.000s)
[67.132504] [008/133] (951s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[67.257434] Starting subtest: basic-flip-after-cursor-legacy
[68.239980] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.986s)
[69.050626] [009/133] (949s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[69.157765] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[69.835153] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[70.020093] [010/133] (949s left) gem_exec_reloc (basic-gtt-cpu-active)
[70.082153] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[70.151602] [011/133] (948s left) kms_chamelium_color (ctm-0-50)
[70.237799] Subtest ctm-0-50: SKIP (0.000s)
[70.287623] [012/133] (948s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[70.379935] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[70.384092] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[70.456910] [013/133] (948s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[70.560253] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[70.589480] Starting dynamic subtest: pipe-A-plane-0
[70.888602] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[70.898063] Starting dynamic subtest: pipe-A-plane-3
[71.121725] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[72.239636] Starting dynamic subtest: pipe-B-plane-0
[72.542740] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[72.553674] Starting dynamic subtest: pipe-B-plane-3
[72.818881] Dynamic subtest pipe-B-plane-3: SUCCESS (0.275s)
[73.137405] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.581s)
[74.017618] [014/133] (945s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[74.108928] Starting subtest: plane-lut1d-ctm3x4
[74.234145] Starting dynamic subtest: pipe-A-plane-0
[74.397478] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[74.407584] Starting dynamic subtest: pipe-A-plane-1
[74.532260] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[74.541481] Starting dynamic subtest: pipe-A-plane-2
[74.708600] Dynamic subtest pipe-A-plane-2: SUCCESS (0.178s)
[75.895053] Starting dynamic subtest: pipe-B-plane-0
[76.032533] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[76.042840] Starting dynamic subtest: pipe-B-plane-1
[76.177167] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[76.186535] Starting dynamic subtest: pipe-B-plane-2
[76.321524] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[77.524336] Starting dynamic subtest: pipe-C-plane-0
[77.650986] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[77.660100] Starting dynamic subtest: pipe-C-plane-1
[77.795538] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[77.803358] Starting dynamic subtest: pipe-C-plane-2
[77.939644] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[79.157614] Starting dynamic subtest: pipe-D-plane-0
[79.296147] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[79.305181] Starting dynamic subtest: pipe-D-plane-1
[79.439558] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[79.448450] Starting dynamic subtest: pipe-D-plane-2
[79.583758] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[79.873915] Subtest plane-lut1d-ctm3x4: SUCCESS (5.770s)
[80.733698] [015/133] (938s left) gem_partial_pwrite_pread (reads)
[80.787257] Subtest reads: SKIP (0.000s)
[80.858726] [016/133] (938s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[80.985926] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[80.990183] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[81.140649] [017/133] (938s left) gem_userptr_blits (usage-restrictions)
[81.203655] Starting subtest: usage-restrictions
[81.205668] Subtest usage-restrictions: SUCCESS (0.000s)
[81.338226] [018/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[81.434610] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[81.438596] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[81.548191] [019/133] (937s left) gem_exec_params (invalid-bsd2-flag-on-render)
[81.602637] Starting subtest: invalid-bsd2-flag-on-render
[81.605045] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[81.695561] [020/133] (937s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[81.748070] Starting subtest: single-wait-all-for-submit-unsubmitted
[81.857985] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[81.946631] [021/133] (937s left) gem_exec_reloc (basic-wc-read)
[82.005489] Subtest basic-wc-read: SKIP (0.000s)
[82.077251] [022/133] (937s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[82.183249] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[86.242391] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.062s)
[87.415847] [023/133] (932s left) gem_exec_fence (submit67)
[87.595943] Starting subtest: submit67
[87.600124] Subtest submit67: SKIP (0.000s)
[89.349666] [024/133] (930s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[89.450977] Starting subtest: y-tiled-64bpp-rotate-0
[89.455484] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[89.552887] [025/133] (930s left) gem_fence_thrash (bo-copy)
[89.590313] Starting subtest: bo-copy
[89.613329] Subtest bo-copy: SKIP (0.020s)
[89.667932] [026/133] (930s left) gem_ctx_freq (sysfs)
[89.731949] Starting subtest: sysfs
[89.734759] Starting dynamic subtest: gt0
[95.251162] Dynamic subtest gt0: SUCCESS (5.519s)
[95.259811] Starting dynamic subtest: gt1
[137.284829] Dynamic subtest gt1: SUCCESS (42.031s)
[137.287501] Subtest sysfs: SUCCESS (47.552s)
[137.411435] [027/133] (882s left) i915_suspend (basic-s3-without-i915)
[137.445284] Starting subtest: basic-s3-without-i915
[139.181256] Subtest basic-s3-without-i915: SKIP (1.731s)
[140.766854] [028/133] (878s left) kms_draw_crc (draw-method-render)
[140.870437] Starting subtest: draw-method-render
[140.872416] Starting dynamic subtest: xrgb8888-untiled
[141.151107] Dynamic subtest xrgb8888-untiled: SUCCESS (0.283s)
[141.158505] Starting dynamic subtest: rgb565-untiled
[141.384326] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[141.394586] Starting dynamic subtest: xrgb2101010-untiled
[141.606064] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[141.613569] Starting dynamic subtest: xbgr16161616f-untiled
[141.839676] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[141.847454] Starting dynamic subtest: xrgb8888-xtiled
[141.961687] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[141.970293] Starting dynamic subtest: rgb565-xtiled
[142.083812] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[142.092335] Starting dynamic subtest: xrgb2101010-xtiled
[142.205948] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[142.214830] Starting dynamic subtest: xbgr16161616f-xtiled
[142.339460] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[142.348163] Starting dynamic subtest: xrgb8888-4tiled
[142.462055] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[142.471763] Starting dynamic subtest: rgb565-4tiled
[142.572965] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[142.580728] Starting dynamic subtest: xrgb2101010-4tiled
[142.695060] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[142.703615] Starting dynamic subtest: xbgr16161616f-4tiled
[142.817191] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[142.819848] Subtest draw-method-render: SUCCESS (1.951s)
[142.932096] [029/133] (876s left) gem_lmem_swapping (parallel-random-verify-ccs)
[142.978742] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[143.017981] [030/133] (876s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[143.133323] Starting subtest: short-busy-flip-before-cursor-toggle
[143.137076] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[143.278818] [031/133] (876s left) vgem_basic (dmabuf-mmap)
[143.319483] Starting subtest: dmabuf-mmap
[143.326812] Subtest dmabuf-mmap: SUCCESS (0.009s)
[143.387193] [032/133] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[143.485952] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[150.705163] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.221s)
[150.840725] [033/133] (869s left) kms_psr (psr2-suspend)
[150.932759] Starting subtest: psr2-suspend
[150.935039] Starting dynamic subtest: eDP-1
[168.463815] Dynamic subtest eDP-1: SUCCESS (2.986s)
[168.466449] Subtest psr2-suspend: SUCCESS (2.986s)
[169.326915] [034/133] (850s left) gem_eio (in-flight-internal-immediate)
[169.505488] Starting subtest: in-flight-internal-immediate
[170.813143] Subtest in-flight-internal-immediate: SUCCESS (1.321s)
[170.923899] [035/133] (849s left) gem_fence_thrash (bo-write-verify-threaded-y)
[170.961697] Starting subtest: bo-write-verify-threaded-y
[170.976032] Subtest bo-write-verify-threaded-y: SKIP (0.015s)
[171.037177] [036/133] (849s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[171.130099] Starting subtest: stress-xrgb8888-yftiled
[171.134462] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[171.198289] [037/133] (848s left) kms_psr (fbc-psr-basic)
[171.292090] Starting subtest: fbc-psr-basic
[171.294290] Starting dynamic subtest: eDP-1
[171.298755] Dynamic subtest eDP-1: SKIP (0.000s)
[171.302873] Subtest fbc-psr-basic: SKIP (0.001s)
[171.367489] [038/133] (848s left) gem_render_copy_redux (flink)
[171.431969] Starting subtest: flink
[172.203958] Subtest flink: SUCCESS (0.780s)
[172.324395] [039/133] (847s left) prime_vgem (fence-read-hang)
[172.395857] Subtest fence-read-hang: SKIP (0.000s)
[172.501546] [040/133] (847s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[172.591974] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[172.595727] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[172.663951] [041/133] (847s left) gem_exec_whisper (basic-queues-forked-all)
[172.726918] Starting subtest: basic-queues-forked-all
[194.204419] Subtest basic-queues-forked-all: SUCCESS (21.544s)
[194.395701] [042/133] (825s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[194.500717] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[194.502884] Starting dynamic subtest: pipe-A-eDP-1
[205.481885] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.985s)
[205.493780] Starting dynamic subtest: pipe-B-eDP-1
[217.221591] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.739s)
[217.224446] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.726s)
[218.067967] [043/133] (802s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[218.121907] Starting subtest: x-tiled-to-vebox-yf-tiled
[218.126386] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[218.315512] [044/133] (802s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[218.408660] Starting subtest: basic-modeset-with-all-modifiers-formats
[218.786425] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[219.545713] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.760s)
[219.556139] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[219.572134] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[219.582589] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[219.589682] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[219.599401] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[219.745427] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[219.757941] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[219.767354] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[219.777165] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[219.789855] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[219.799000] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[219.812075] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[219.821705] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[219.834196] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[219.843803] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[219.856552] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[219.865590] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[219.878727] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[219.890548] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[219.901165] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[219.910537] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[219.923199] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[219.933810] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[220.078921] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[220.089940] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[220.100783] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[220.113255] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[220.123264] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[220.133793] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[220.145468] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[220.157429] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[220.167651] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[220.176917] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[220.190290] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[220.199627] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[220.211945] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[220.221501] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[220.233962] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[220.243853] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[220.258651] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[220.267976] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[220.412413] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[220.422966] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[220.434667] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[220.444003] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[220.456659] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[220.468472] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[220.478670] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[220.487646] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[220.501111] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[220.512600] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[220.523133] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[220.532473] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[220.545176] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[220.556658] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[220.567420] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[220.576521] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[220.589715] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[221.002252] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.595s)
[221.829086] [045/133] (798s left) kms_psr (pr-cursor-blt)
[221.931642] Starting subtest: pr-cursor-blt
[221.936181] Subtest pr-cursor-blt: SKIP (0.000s)
[222.007313] [046/133] (798s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[222.095163] Starting subtest: fbc-rgb565-draw-blt
[226.288245] Subtest fbc-rgb565-draw-blt: SUCCESS (4.198s)
[227.418033] [047/133] (793s left) kms_selftest (drm_cmdline_parser)
[227.451724] Starting subtest: drm_cmdline_parser
[227.476010] Starting dynamic subtest: drm_test_cmdline_force_d_only
[227.593495] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.117s)
[227.605210] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[227.669355] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.073s)
[227.679289] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[227.771848] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.104s)
[227.787935] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[227.894055] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.118s)
[227.905590] Starting dynamic subtest: drm_test_cmdline_force_e_only
[228.005857] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.112s)
[228.017377] Starting dynamic subtest: drm_test_cmdline_res
[228.110798] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.103s)
[228.122716] Starting dynamic subtest: drm_test_cmdline_res_vesa
[228.215790] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.103s)
[228.228220] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[228.304891] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.091s)
[228.314063] Starting dynamic subtest: drm_test_cmdline_res_rblank
[228.393446] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.087s)
[228.404440] Starting dynamic subtest: drm_test_cmdline_res_bpp
[228.494347] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.101s)
[228.505508] Starting dynamic subtest: drm_test_cmdline_res_refresh
[228.603390] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.107s)
[228.612799] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[228.719104] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.115s)
[228.728180] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[228.818914] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.101s)
[228.827947] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[228.915183] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.095s)
[228.925262] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[229.008990] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.091s)
[229.022103] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[229.116663] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.108s)
[229.126491] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[229.199681] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.081s)
[229.208585] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[229.301802] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.101s)
[229.310575] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[229.403421] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.100s)
[229.414770] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[229.506422] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.104s)
[229.517499] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[229.608678] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.102s)
[229.619850] Starting dynamic subtest: drm_test_cmdline_name
[229.706711] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.097s)
[229.717950] Starting dynamic subtest: drm_test_cmdline_name_bpp
[229.796003] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.089s)
[229.804787] Starting dynamic subtest: drm_test_cmdline_name_option
[229.882312] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.086s)
[229.891174] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[229.983152] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.101s)
[229.994532] Starting dynamic subtest: drm_test_cmdline_rotate_0
[230.087853] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.103s)
[230.098842] Starting dynamic subtest: drm_test_cmdline_rotate_90
[230.183916] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.095s)
[230.197019] Starting dynamic subtest: drm_test_cmdline_rotate_180
[230.287907] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.103s)
[230.298153] Starting dynamic subtest: drm_test_cmdline_rotate_270
[230.385684] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.096s)
[230.396760] Starting dynamic subtest: drm_test_cmdline_hmirror
[230.476385] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.089s)
[230.485405] Starting dynamic subtest: drm_test_cmdline_vmirror
[230.572240] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.095s)
[230.581518] Starting dynamic subtest: drm_test_cmdline_margin_options
[230.660188] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.087s)
[230.677183] Starting dynamic subtest: drm_test_cmdline_multiple_options
[230.748968] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.088s)
[230.760849] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[230.843306] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.093s)
[230.853562] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[230.949711] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.103s)
[230.959379] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[231.050098] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.101s)
[231.058925] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[231.151298] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.101s)
[231.165819] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[231.249945] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.098s)
[231.258792] Starting dynamic subtest: drm_test_cmdline_invalid
[231.347575] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.097s)
[231.356548] Starting dynamic subtest: drm_test_cmdline_tv_options
[231.453694] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.104s)
[231.455347] Subtest drm_cmdline_parser: SUCCESS (4.004s)
[231.638717] [048/133] (788s left) gem_pwrite (basic-self)
[231.691128] Subtest basic-self: SKIP (0.000s)
[231.758687] [049/133] (788s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[231.858315] Starting subtest: 2x-plain-flip-ts-check-interruptible
[231.870123] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[231.946183] [050/133] (788s left) gem_exec_whisper (basic-fds-forked)
[232.008830] Starting subtest: basic-fds-forked
[256.361762] Subtest basic-fds-forked: SUCCESS (24.353s)
[256.543833] [051/133] (764s left) kms_atomic (plane-invalid-params)
[256.643475] Starting subtest: plane-invalid-params
[256.645791] Starting dynamic subtest: pipe-A-eDP-1
[257.031830] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s)
[257.033703] Subtest plane-invalid-params: SUCCESS (0.389s)
[257.838334] [052/133] (762s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[257.940018] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[257.944382] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[258.039470] [053/133] (762s left) gem_softpin (evict-single-offset)
[258.091053] Starting subtest: evict-single-offset
[282.840038] Subtest evict-single-offset: SUCCESS (24.741s)
[282.963705] [054/133] (737s left) api_intel_bb (simple-bb)
[283.054858] Starting subtest: simple-bb
[283.062297] Subtest simple-bb: SUCCESS (0.010s)
[283.186708] [055/133] (737s left) kms_atomic_interruptible (universal-setplane-primary)
[283.290404] Starting subtest: universal-setplane-primary
[283.292655] Starting dynamic subtest: pipe-A-eDP-1
[290.665150] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.373s)
[290.667536] Subtest universal-setplane-primary: SUCCESS (7.374s)
[291.526543] [056/133] (729s left) kms_flip (plain-flip-interruptible)
[291.620713] Starting subtest: plain-flip-interruptible
[291.623192] Starting dynamic subtest: A-eDP1
[293.318069] Dynamic subtest A-eDP1: SUCCESS (1.697s)
[293.329951] Starting dynamic subtest: B-eDP1
[294.950579] Dynamic subtest B-eDP1: SUCCESS (1.630s)
[294.962777] Starting dynamic subtest: C-eDP1
[296.582315] Dynamic subtest C-eDP1: SUCCESS (1.630s)
[296.593899] Starting dynamic subtest: D-eDP1
[298.202046] Dynamic subtest D-eDP1: SUCCESS (1.619s)
[298.207871] Subtest plain-flip-interruptible: SUCCESS (6.586s)
[299.382383] [057/133] (721s left) kms_content_protection (atomic-hdcp14)
[299.521026] Starting subtest: atomic-hdcp14
[299.525853] Subtest atomic-hdcp14: SKIP (0.000s)
[299.638080] [058/133] (721s left) kms_chamelium_edid (vga-edid-read)
[300.025069] Subtest vga-edid-read: SKIP (0.000s)
[300.800016] [059/133] (720s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[300.892927] Starting subtest: primary-x-tiled-reflect-x-0
[307.821409] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.932s)
[309.017339] [060/133] (712s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[309.074317] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[309.179210] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[309.273171] [061/133] (711s left) gem_exec_params (rs-invalid)
[309.319467] Starting subtest: rs-invalid
[309.324751] Subtest rs-invalid: SUCCESS (0.003s)
[309.429553] [062/133] (711s left) kms_pm_rpm (modeset-lpsp)
[310.976964] Starting subtest: modeset-lpsp
[312.420142] Subtest modeset-lpsp: SUCCESS (1.445s)
[312.509769] [063/133] (708s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[312.602295] Starting subtest: fbc-rgb565-draw-mmap-cpu
[316.571266] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.973s)
[317.699083] [064/133] (703s left) kms_cursor_crc (cursor-offscreen-256x256)
[317.981531] Starting subtest: cursor-offscreen-256x256
[317.986865] Starting dynamic subtest: pipe-A-eDP-1
[319.943038] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.957s)
[319.972357] Starting dynamic subtest: pipe-D-eDP-1
[322.600862] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.636s)
[322.602763] Subtest cursor-offscreen-256x256: SUCCESS (4.618s)
[323.473906] [065/133] (697s left) prime_vgem (wait)
[323.556309] Starting subtest: wait
[323.558310] Starting dynamic subtest: rcs0
[323.616654] Dynamic subtest rcs0: SUCCESS (0.063s)
[323.627453] Starting dynamic subtest: bcs0
[323.677578] Dynamic subtest bcs0: SUCCESS (0.060s)
[323.688081] Starting dynamic subtest: vcs0
[323.729861] Dynamic subtest vcs0: SUCCESS (0.051s)
[323.740153] Starting dynamic subtest: vcs1
[323.773274] Dynamic subtest vcs1: SUCCESS (0.043s)
[323.783942] Starting dynamic subtest: vecs0
[323.819688] Dynamic subtest vecs0: SUCCESS (0.046s)
[323.829595] Starting dynamic subtest: ccs0
[323.867352] Dynamic subtest ccs0: SUCCESS (0.047s)
[323.869455] Subtest wait: SUCCESS (0.315s)
[323.984657] [066/133] (697s left) kms_psr (psr-dpms)
[324.077724] Starting subtest: psr-dpms
[324.079830] Starting dynamic subtest: eDP-1
[327.005430] Dynamic subtest eDP-1: SUCCESS (2.928s)
[327.007751] Subtest psr-dpms: SUCCESS (2.929s)
[327.867886] [067/133] (693s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[327.962270] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[327.966277] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[328.065443] [068/133] (693s left) sysfs_heartbeat_interval (nopreempt)
[328.119123] Starting subtest: nopreempt
[328.121541] Starting dynamic subtest: vecs0
[337.882423] Dynamic subtest vecs0: SUCCESS (9.761s)
[337.895454] Starting dynamic subtest: ccs0
[341.925579] Dynamic subtest ccs0: SUCCESS (4.044s)
[341.937158] Starting dynamic subtest: vcs0
[351.822816] Dynamic subtest vcs0: SUCCESS (9.898s)
[351.836026] Starting dynamic subtest: bcs0
[355.770179] Dynamic subtest bcs0: SUCCESS (3.945s)
[355.782096] Starting dynamic subtest: rcs0
[359.739561] Dynamic subtest rcs0: SUCCESS (3.968s)
[359.751699] Starting dynamic subtest: vcs1
[368.858529] Dynamic subtest vcs1: SUCCESS (9.118s)
[368.860978] Subtest nopreempt: SUCCESS (40.746s)
[368.935068] [069/133] (652s left) dumb_buffer (map-uaf)
[369.006888] Starting subtest: map-uaf
[369.012133] Subtest map-uaf: SUCCESS (0.005s)
[369.097403] [070/133] (652s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[369.157585] Starting subtest: y-tiled-to-vebox-y-tiled
[369.162103] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[369.361024] [071/133] (652s left) gem_mmap_wc (read-write)
[369.415063] Subtest read-write: SKIP (0.000s)
[369.506056] [072/133] (652s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[369.821037] Starting subtest: cursor-rapid-movement-512x170
[369.825454] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[369.971694] [073/133] (651s left) kms_properties (invalid-properties-legacy)
[370.059994] Starting subtest: invalid-properties-legacy
[370.163684] Subtest invalid-properties-legacy: SUCCESS (0.105s)
[370.233276] [074/133] (651s left) gem_vm_create (isolation)
[370.293972] Starting subtest: isolation
[370.302479] Subtest isolation: SUCCESS (0.009s)
[370.430231] [075/133] (651s left) kms_pm_dc (dc6-dpms)
[371.528988] Starting subtest: dc6-dpms
[373.627384] Subtest dc6-dpms: SUCCESS (2.099s)
[373.703541] [076/133] (648s left) kms_lease (lease-revoke)
[373.790283] Starting subtest: lease-revoke
[373.792423] Starting dynamic subtest: pipe-A-eDP-1
[373.822175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[373.835364] Starting dynamic subtest: pipe-B-eDP-1
[373.849590] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[373.867429] Starting dynamic subtest: pipe-C-eDP-1
[373.883948] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.030s)
[373.895153] Starting dynamic subtest: pipe-D-eDP-1
[373.915693] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.030s)
[373.917977] Subtest lease-revoke: SUCCESS (0.127s)
[374.036406] [077/133] (647s left) gem_mmap_gtt (hang-busy)
[374.104357] Subtest hang-busy: SKIP (0.000s)
[374.171471] [078/133] (647s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[374.256740] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[374.261020] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[374.335621] [079/133] (647s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[374.391193] Starting subtest: etime-multi-wait-available-unsubmitted
[374.500071] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.108s)
[374.576542] [080/133] (647s left) kms_cursor_edge_walk (256x256-right-edge)
[374.672889] Starting subtest: 256x256-right-edge
[374.675280] Starting dynamic subtest: pipe-A-eDP-1
[378.165043] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[378.176630] Starting dynamic subtest: pipe-D-eDP-1
[381.372440] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.209s)
[381.374712] Subtest 256x256-right-edge: SUCCESS (6.704s)
[382.173461] [081/133] (639s left) kms_prop_blob (blob-multiple)
[382.224736] Starting subtest: blob-multiple
[382.227014] Subtest blob-multiple: SUCCESS (0.002s)
[382.341318] [082/133] (639s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[382.400248] Starting subtest: invalid-signal-one-illegal-handle
[382.402459] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[382.485105] [083/133] (639s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[382.605455] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[382.609844] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[382.710418] [084/133] (639s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[382.827271] Starting subtest: short-flip-after-cursor-atomic-transitions
[383.773873] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.945s)
[384.599056] [085/133] (637s left) gem_exec_reloc (basic-cpu-read)
[384.666480] Subtest basic-cpu-read: SKIP (0.000s)
[384.739273] [086/133] (637s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[384.836092] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[384.838196] Starting dynamic subtest: pipe-A-eDP-1
[384.860695] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[384.874386] Starting dynamic subtest: pipe-B-eDP-1
[384.895723] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[384.905685] Starting dynamic subtest: pipe-C-eDP-1
[384.927176] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[384.937186] Starting dynamic subtest: pipe-D-eDP-1
[384.959224] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[384.963334] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[387.173858] [087/133] (635s left) i915_drm_fdinfo (virtual-busy)
[387.220248] Starting subtest: virtual-busy
[387.224508] Subtest virtual-busy: SKIP (0.000s)
[387.288216] [088/133] (635s left) gem_exec_schedule (preempt-queue-contexts)
[387.359793] Subtest preempt-queue-contexts: SKIP (0.000s)
[387.664492] [089/133] (634s left) kms_chamelium_hpd (hdmi-hpd-fast)
[388.058629] Subtest hdmi-hpd-fast: SKIP (0.000s)
[388.882757] [090/133] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[388.977035] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[396.088339] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.114s)
[396.189374] [091/133] (626s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[396.303135] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[396.994927] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.693s)
[397.172310] [092/133] (625s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[397.274786] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[397.277069] Starting dynamic subtest: pipe-A
[397.337210] Dynamic subtest pipe-A: SUCCESS (0.065s)
[397.347351] Starting dynamic subtest: pipe-B
[398.452650] Dynamic subtest pipe-B: SUCCESS (1.114s)
[398.465554] Starting dynamic subtest: pipe-C
[399.570096] Dynamic subtest pipe-C: SUCCESS (1.116s)
[399.580848] Starting dynamic subtest: pipe-D
[400.702396] Dynamic subtest pipe-D: SUCCESS (1.132s)
[400.704674] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.430s)
[401.878851] [093/133] (620s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[401.967894] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[409.042562] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.076s)
[409.166661] [094/133] (613s left) syncobj_eventfd (binary-wait-before-signal)
[409.228136] Starting subtest: binary-wait-before-signal
[409.256812] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[409.330458] [095/133] (613s left) gem_compute (compute-square)
[409.384662] Starting subtest: compute-square
[409.388693] Subtest compute-square: SUCCESS (0.006s)
[409.521348] [096/133] (613s left) syncobj_timeline (signal)
[409.578844] Starting subtest: signal
[409.581127] Subtest signal: SUCCESS (0.000s)
[409.671191] [097/133] (613s left) perf_pmu (interrupts-sync)
[409.717726] Starting subtest: interrupts-sync
[410.802685] Subtest interrupts-sync: SUCCESS (1.085s)
[410.910076] [098/133] (611s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[410.997865] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[411.000138] Starting dynamic subtest: pipe-A-eDP-1
[411.060640] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[411.072665] Starting dynamic subtest: pipe-B-eDP-1
[411.130599] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[411.142302] Starting dynamic subtest: pipe-C-eDP-1
[411.199887] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[411.211902] Starting dynamic subtest: pipe-D-eDP-1
[411.269570] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[411.274126] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[413.232251] [099/133] (609s left) perf_pmu (busy-accuracy-50)
[413.270197] Starting subtest: busy-accuracy-50
[413.272614] Starting dynamic subtest: rcs0
[414.808937] Dynamic subtest rcs0: SUCCESS (1.531s)
[414.819338] Starting dynamic subtest: bcs0
[416.345716] Dynamic subtest bcs0: SUCCESS (1.539s)
[416.357208] Starting dynamic subtest: vcs0
[417.889878] Dynamic subtest vcs0: SUCCESS (1.542s)
[417.901319] Starting dynamic subtest: vcs1
[419.433646] Dynamic subtest vcs1: SUCCESS (1.542s)
[419.445859] Starting dynamic subtest: vecs0
[420.975202] Dynamic subtest vecs0: SUCCESS (1.540s)
[420.987563] Starting dynamic subtest: ccs0
[422.522441] Dynamic subtest ccs0: SUCCESS (1.545s)
[422.524873] Subtest busy-accuracy-50: SUCCESS (9.252s)
[422.640409] [100/133] (600s left) kms_addfb_basic (bad-pitch-32)
[422.693643] Starting subtest: bad-pitch-32
[422.696104] Subtest bad-pitch-32: SUCCESS (0.000s)
[422.833844] [101/133] (600s left) gem_exec_balancer (invalid-balancer)
[422.908365] Starting subtest: invalid-balancer
[423.837032] Subtest invalid-balancer: SUCCESS (0.928s)
[424.151861] [102/133] (598s left) syncobj_timeline (reset-multiple-signaled)
[424.214143] Starting subtest: reset-multiple-signaled
[424.216478] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[424.309045] [103/133] (598s left) i915_pm_rpm (sysfs-read)
[426.029937] Starting subtest: sysfs-read
[427.173663] Subtest sysfs-read: SUCCESS (1.145s)
[427.557138] [104/133] (595s left) kms_psr (fbc-pr-cursor-plane-move)
[427.645010] Starting subtest: fbc-pr-cursor-plane-move
[427.649288] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[427.716064] [105/133] (595s left) gem_ctx_persistence (processes)
[427.770963] Starting subtest: processes
[429.771893] Subtest processes: SUCCESS (2.001s)
[429.849992] [106/133] (593s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[429.944492] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[429.946798] Starting dynamic subtest: pipe-A-eDP-1
[429.969535] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.981539] Starting dynamic subtest: pipe-B-eDP-1
[430.004527] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[430.016969] Starting dynamic subtest: pipe-C-eDP-1
[430.039485] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[430.050067] Starting dynamic subtest: pipe-D-eDP-1
[430.072207] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[430.076307] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[432.131147] [107/133] (591s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[432.233807] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[432.236092] Starting dynamic subtest: pipe-A
[432.571996] Dynamic subtest pipe-A: SUCCESS (0.340s)
[432.583391] Starting dynamic subtest: pipe-B
[434.016844] Dynamic subtest pipe-B: SUCCESS (1.444s)
[434.029457] Starting dynamic subtest: pipe-C
[435.441919] Dynamic subtest pipe-C: SUCCESS (1.423s)
[435.453352] Starting dynamic subtest: pipe-D
[436.867191] Dynamic subtest pipe-D: SUCCESS (1.424s)
[436.869506] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.636s)
[438.034641] [108/133] (585s left) kms_invalid_mode (uint-max-clock)
[438.140276] Starting subtest: uint-max-clock
[438.142647] Starting dynamic subtest: pipe-A-eDP-1
[438.430006] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[438.441136] Starting dynamic subtest: pipe-B-eDP-1
[438.443350] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[438.453650] Starting dynamic subtest: pipe-C-eDP-1
[438.455465] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[438.466037] Starting dynamic subtest: pipe-D-eDP-1
[438.468373] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[438.470691] Subtest uint-max-clock: SUCCESS (0.296s)
[439.271368] [109/133] (583s left) prime_mmap (test_map_unmap)
[439.332213] Starting subtest: test_map_unmap
[439.334493] Starting dynamic subtest: test_map_unmap-smem
[439.360753] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[439.363175] Subtest test_map_unmap: SUCCESS (0.031s)
[439.466744] [110/133] (583s left) kms_psr (fbc-psr2-cursor-plane-move)
[439.565374] Starting subtest: fbc-psr2-cursor-plane-move
[439.567577] Starting dynamic subtest: eDP-1
[439.571731] Dynamic subtest eDP-1: SKIP (0.000s)
[439.575783] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[439.638423] [111/133] (583s left) gem_set_tiling_vs_pwrite
[439.751877] [112/133] (583s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[439.854016] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[439.855913] Starting dynamic subtest: pipe-A-eDP-1
[441.213669] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.360s)
[441.495149] Starting dynamic subtest: pipe-B-eDP-1
[442.543531] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.058s)
[442.825264] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.973s)
[443.660108] [113/133] (579s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[443.753042] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[443.763903] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[443.851819] [114/133] (579s left) gem_exec_flush (basic-wb-ro-default)
[443.911419] Starting subtest: basic-wb-ro-default
[449.366431] Subtest basic-wb-ro-default: SUCCESS (5.456s)
[449.562015] [115/133] (573s left) perf_pmu (rc6-suspend)
[449.603849] Starting subtest: rc6-suspend
[472.208383] Subtest rc6-suspend: SUCCESS (7.542s)
[473.091691] [116/133] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[473.197401] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[480.115237] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.958s)
[480.241870] [117/133] (543s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[480.342304] Starting subtest: x-tiled-32bpp-rotate-0
[481.782937] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.445s)
[481.918678] [118/133] (541s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[482.018460] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[482.022108] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[482.126498] [119/133] (541s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[482.213330] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[482.216722] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[482.312151] [120/133] (541s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[482.420491] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[482.422057] Starting dynamic subtest: pipe-A-eDP-1
[484.551131] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.135s)
[484.562226] Starting dynamic subtest: pipe-B-eDP-1
[486.838927] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.292s)
[486.849888] Starting dynamic subtest: pipe-C-eDP-1
[488.864555] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.025s)
[488.875812] Starting dynamic subtest: pipe-D-eDP-1
[490.901733] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.040s)
[490.904091] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.497s)
[492.067189] [121/133] (531s left) gem_fence_thrash (bo-write-verify-none)
[492.109480] Starting subtest: bo-write-verify-none
[492.129431] Subtest bo-write-verify-none: SKIP (0.016s)
[492.192496] [122/133] (531s left) gem_softpin (noreloc)
[492.251927] Starting subtest: noreloc
[497.671193] Subtest noreloc: SUCCESS (5.423s)
[497.796612] [123/133] (526s left) kms_getfb (getfb-reject-nv12)
[497.887573] Starting subtest: getfb-reject-nv12
[497.889902] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[497.980526] [124/133] (525s left) gem_partial_pwrite_pread (writes-after-reads-display)
[498.043437] Subtest writes-after-reads-display: SKIP (0.000s)
[498.123894] [125/133] (525s left) kms_properties (get_properties-sanity-atomic)
[498.207624] Starting subtest: get_properties-sanity-atomic
[498.209779] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[498.287797] [126/133] (525s left) kms_busy (basic)
[498.387830] Starting subtest: basic
[498.390134] Starting dynamic subtest: flip
[498.977547] Dynamic subtest flip: SUCCESS (0.589s)
[498.988250] Starting dynamic subtest: modeset
[502.375993] Dynamic subtest modeset: SUCCESS (3.399s)
[502.378281] Subtest basic: SUCCESS (3.991s)
[503.168658] [127/133] (520s left) gem_exec_schedule (submit-late-slice)
[503.244581] Starting subtest: submit-late-slice
[503.246920] Starting dynamic subtest: rcs0
[503.273838] Dynamic subtest rcs0: SUCCESS (0.038s)
[503.291502] Starting dynamic subtest: bcs0
[503.307650] Dynamic subtest bcs0: SUCCESS (0.031s)
[503.319577] Starting dynamic subtest: vcs0
[503.342044] Dynamic subtest vcs0: SUCCESS (0.034s)
[503.353593] Starting dynamic subtest: vcs1
[503.399432] Dynamic subtest vcs1: SUCCESS (0.056s)
[503.412067] Starting dynamic subtest: vecs0
[503.430183] Dynamic subtest vecs0: SUCCESS (0.029s)
[503.449276] Starting dynamic subtest: ccs0
[503.467486] Dynamic subtest ccs0: SUCCESS (0.035s)
[503.469717] Subtest submit-late-slice: SUCCESS (0.232s)
[505.019900] [128/133] (519s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[505.119027] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[511.827145] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.708s)
[511.942581] [129/133] (512s left) kms_big_fb (linear-16bpp-rotate-90)
[512.038409] Starting subtest: linear-16bpp-rotate-90
[512.057834] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[512.172229] [130/133] (511s left) drm_read (short-buffer-wakeup)
[512.314768] Starting subtest: short-buffer-wakeup
[544.522998] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[544.670795] [131/133] (479s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[544.789239] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[544.793620] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[544.871200] [132/133] (479s left) i915_drm_fdinfo (virtual-idle)
[544.911342] Starting subtest: virtual-idle
[547.976444] Subtest virtual-idle: SUCCESS (3.065s)
[548.054660] [133/133] (476s left) gem_exec_fence (expired-history)
[548.528473] Starting subtest: expired-history
[555.661534] Subtest expired-history: SUCCESS (7.135s)
[556.246738] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: kms_atomic_transition
results: parsing output: 4/ for test: vgem_basic
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_chamelium_color
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_color_pipeline
results: parsing output: 14/ for test: gem_partial_pwrite_pread
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_exec_params
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_fence_thrash
results: parsing output: 25/ for test: gem_ctx_freq
results: parsing output: 26/ for test: i915_suspend
results: parsing output: 27/ for test: kms_draw_crc
results: parsing output: 28/ for test: gem_lmem_swapping
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: vgem_basic
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: gem_fence_thrash
results: parsing output: 35/ for test: kms_pipe_stress
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_render_copy_redux
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: gem_exec_whisper
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_async_flips
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_selftest
results: parsing output: 47/ for test: gem_pwrite
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_atomic
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_softpin
results: parsing output: 53/ for test: api_intel_bb
results: parsing output: 54/ for test: kms_atomic_interruptible
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: kms_chamelium_edid
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: prime_vgem
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: sysfs_heartbeat_interval
results: parsing output: 68/ for test: dumb_buffer
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: kms_properties
results: parsing output: 73/ for test: gem_vm_create
results: parsing output: 74/ for test: kms_pm_dc
results: parsing output: 75/ for test: kms_lease
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_cursor_edge_walk
results: parsing output: 80/ for test: kms_prop_blob
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_chamelium_hpd
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_plane_scaling
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_eventfd
results: parsing output: 94/ for test: gem_compute
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: i915_pm_rpm
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: gem_ctx_persistence
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_invalid_mode
results: parsing output: 108/ for test: prime_mmap
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 111/ for test: kms_atomic_transition
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: gem_fence_thrash
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: gem_partial_pwrite_pread
results: parsing output: 124/ for test: kms_properties
results: parsing output: 125/ for test: kms_busy
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: drm_read
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_drm_fdinfo
results: parsing output: 132/ for test: gem_exec_fence
Done.