[58.851932] Initializing watchdogs
[58.851983]   /dev/watchdog0
[58.867078] [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.871484] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.873668] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.876969] [001/156] (960s left) gem_workarounds (basic-read)
[58.976606] Starting subtest: basic-read
[58.989451] Subtest basic-read: SUCCESS (0.013s)
[59.114681] [002/156] (960s left) kms_addfb_basic (too-high)
[59.219531] Starting subtest: too-high
[59.221368] Subtest too-high: SUCCESS (0.001s)
[59.310846] [003/156] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[59.420589] Starting subtest: psr-rgb565-draw-mmap-gtt
[59.424709] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[59.530205] [004/156] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[59.636597] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[59.641153] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[59.729264] [005/156] (959s left) gen9_exec_parse (allowed-all)
[59.782568] Subtest allowed-all: SKIP (0.000s)
[59.845664] [006/156] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[59.939048] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[59.942689] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[60.028012] [007/156] (959s left) gem_exec_fence (submit67)
[60.197081] Starting subtest: submit67
[60.201553] Subtest submit67: SKIP (0.000s)
[62.378663] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[62.382009] [008/156] (957s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[62.496448] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[62.500704] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[62.592680] [009/156] (957s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[62.651488] Starting subtest: multi-wait-available-unsubmitted-signaled
[62.653389] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[62.755366] [010/156] (956s left) gem_exec_async (concurrent-writes)
[62.813756] Starting subtest: concurrent-writes
[62.816062] Starting dynamic subtest: rcs0
[62.829868] Dynamic subtest rcs0: SUCCESS (0.016s)
[62.840225] Starting dynamic subtest: bcs0
[62.842453] Dynamic subtest bcs0: SUCCESS (0.006s)
[62.854662] Starting dynamic subtest: vcs0
[62.856972] Dynamic subtest vcs0: SUCCESS (0.005s)
[62.866319] Starting dynamic subtest: vcs1
[62.868455] Dynamic subtest vcs1: SUCCESS (0.006s)
[62.875723] Starting dynamic subtest: vecs0
[62.877904] Dynamic subtest vecs0: SUCCESS (0.005s)
[62.885091] Starting dynamic subtest: ccs0
[62.887211] Dynamic subtest ccs0: SUCCESS (0.006s)
[62.889298] Subtest concurrent-writes: SUCCESS (0.047s)
[63.082650] [011/156] (956s left) kms_frontbuffer_tracking (psrhdr-suspend)
[63.183521] Starting subtest: psrhdr-suspend
[63.188023] Subtest psrhdr-suspend: SKIP (0.000s)
[63.276163] [012/156] (956s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite)
[63.370881] Starting subtest: psrhdr-rgb101010-draw-pwrite
[63.374586] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[63.468159] [013/156] (956s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[63.567596] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[63.571082] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[63.668078] [014/156] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[63.770276] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[63.773730] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[63.866200] [015/156] (956s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[63.966991] Starting subtest: 4-tiled-8bpp-rotate-0
[65.208698] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.251s)
[65.342838] [016/156] (954s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[65.446872] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[65.450457] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[65.552672] [017/156] (954s left) gem_ctx_persistence (heartbeat-hang)
[65.618359] Starting subtest: heartbeat-hang
[65.622264] Subtest heartbeat-hang: SKIP (0.000s)
[65.724187] [018/156] (954s left) gem_softpin (evict-prime-sanity-check)
[65.776467] Starting subtest: evict-prime-sanity-check
[65.778080] Starting dynamic subtest: rcs0
[66.908868] Dynamic subtest rcs0: SUCCESS (1.140s)
[66.921767] Starting dynamic subtest: bcs0
[68.017780] Dynamic subtest bcs0: SUCCESS (1.115s)
[68.026895] Starting dynamic subtest: vcs0
[69.342548] Dynamic subtest vcs0: SUCCESS (1.329s)
[69.354490] Starting dynamic subtest: vcs1
[71.329757] Dynamic subtest vcs1: SUCCESS (1.993s)
[71.340342] Starting dynamic subtest: vecs0
[73.286844] Dynamic subtest vecs0: SUCCESS (1.962s)
[73.299394] Starting dynamic subtest: ccs0
[74.511210] Dynamic subtest ccs0: SUCCESS (1.227s)
[74.524917] Starting dynamic subtest: all
[75.627924] Dynamic subtest all: SUCCESS (1.118s)
[75.631635] Subtest evict-prime-sanity-check: SUCCESS (9.891s)
[75.710336] [019/156] (944s left) gem_mmap_gtt (basic-small-copy)
[75.765568] Subtest basic-small-copy: SKIP (0.000s)
[75.831872] [020/156] (944s left) gem_mmap_gtt (zero-extend)
[75.886988] Subtest zero-extend: SKIP (0.000s)
[75.946780] [021/156] (944s left) kms_color (invalid-gamma-lut-sizes)
[76.041249] Starting subtest: invalid-gamma-lut-sizes
[76.043557] Starting dynamic subtest: pipe-A
[76.336434] Dynamic subtest pipe-A: SUCCESS (0.295s)
[76.346977] Starting dynamic subtest: pipe-B
[76.349406] Dynamic subtest pipe-B: SUCCESS (0.000s)
[76.358953] Starting dynamic subtest: pipe-C
[76.361453] Dynamic subtest pipe-C: SUCCESS (0.000s)
[76.371045] Starting dynamic subtest: pipe-D
[76.373303] Dynamic subtest pipe-D: SUCCESS (0.000s)
[76.375263] Subtest invalid-gamma-lut-sizes: SUCCESS (0.297s)
[77.141195] [022/156] (943s left) gem_mmap_gtt (hang)
[77.199352] Subtest hang: SKIP (0.000s)
[77.255696] [023/156] (942s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[77.357260] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[77.991346] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[78.177698] [024/156] (942s left) kms_flip (nonexisting-fb-interruptible)
[78.267578] Starting subtest: nonexisting-fb-interruptible
[78.269871] Starting dynamic subtest: A-eDP1
[79.428612] Dynamic subtest A-eDP1: SUCCESS (1.160s)
[79.438927] Starting dynamic subtest: B-eDP1
[80.560629] Dynamic subtest B-eDP1: SUCCESS (1.133s)
[80.570276] Starting dynamic subtest: C-eDP1
[81.696232] Dynamic subtest C-eDP1: SUCCESS (1.135s)
[81.707270] Starting dynamic subtest: D-eDP1
[82.825563] Dynamic subtest D-eDP1: SUCCESS (1.128s)
[82.831609] Subtest nonexisting-fb-interruptible: SUCCESS (4.566s)
[83.997165] [025/156] (936s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[84.106744] Starting subtest: fbcpsr-modesetfrombusy
[90.366720] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.266s)
[90.504489] [026/156] (929s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[90.603039] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[90.606765] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[90.709275] [027/156] (929s left) gem_exec_parallel (userptr)
[90.771253] Starting subtest: userptr
[90.773307] Starting dynamic subtest: rcs0
[92.217116] Dynamic subtest rcs0: SUCCESS (1.445s)
[92.228286] Starting dynamic subtest: bcs0
[93.709201] Dynamic subtest bcs0: SUCCESS (1.491s)
[93.717653] Starting dynamic subtest: vcs0
[95.355465] Dynamic subtest vcs0: SUCCESS (1.644s)
[95.366684] Starting dynamic subtest: vcs1
[97.311669] Dynamic subtest vcs1: SUCCESS (1.955s)
[97.320796] Starting dynamic subtest: vecs0
[99.295709] Dynamic subtest vecs0: SUCCESS (1.983s)
[99.307100] Starting dynamic subtest: ccs0
[100.823915] Dynamic subtest ccs0: SUCCESS (1.529s)
[100.826295] Subtest userptr: SUCCESS (10.052s)
[101.011354] [028/156] (919s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[101.117106] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[101.121314] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[101.229769] [029/156] (919s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[101.329731] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[101.333944] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[101.441158] [030/156] (919s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[101.506133] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[101.612242] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[101.700204] [031/156] (918s left) gem_fence_thrash (bo-write-verify-x)
[101.737227] Starting subtest: bo-write-verify-x
[101.759044] Subtest bo-write-verify-x: SKIP (0.018s)
[101.821118] [032/156] (918s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[101.919857] Starting subtest: fbc-psr2-sprite-mmap-gtt
[101.922143] Starting dynamic subtest: eDP-1
[101.926603] Dynamic subtest eDP-1: SKIP (0.000s)
[101.931065] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[101.991329] [033/156] (918s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[102.051755] Starting subtest: multi-wait-all-available-submitted-signaled
[102.054852] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[102.149168] [034/156] (918s left) gem_exec_params (rel-constants-invalid)
[102.207777] Starting subtest: rel-constants-invalid
[102.210217] Subtest rel-constants-invalid: SUCCESS (0.000s)
[102.313195] [035/156] (918s left) kms_properties (connector-properties-legacy)
[102.413531] Starting subtest: connector-properties-legacy
[102.415850] Starting dynamic subtest: pipe-A-eDP-1
[110.225697] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.811s)
[110.235346] Starting dynamic subtest: pipe-None-DP-1
[110.239514] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[110.247397] Starting dynamic subtest: pipe-None-HDMI-A-1
[110.251651] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[110.259334] Starting dynamic subtest: pipe-None-DP-2
[110.263194] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[110.270911] Starting dynamic subtest: pipe-None-HDMI-A-2
[110.274738] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[110.282945] Starting dynamic subtest: pipe-None-DP-3
[110.287390] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[110.295595] Starting dynamic subtest: pipe-None-DP-4
[110.300059] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[110.302263] Subtest connector-properties-legacy: SUCCESS (7.820s)
[111.090434] [036/156] (909s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[111.200305] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[111.204520] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[111.294888] [037/156] (909s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw)
[111.388570] Starting subtest: fbchdr-1p-pri-indfb-multidraw
[111.392961] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[111.483976] [038/156] (909s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[111.584793] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[111.588913] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[111.688998] [039/156] (909s left) kms_chamelium_color (ctm-red-to-blue)
[111.772382] Subtest ctm-red-to-blue: SKIP (0.000s)
[111.821385] [040/156] (909s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[111.925247] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[111.929478] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[112.036719] [041/156] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[112.144919] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[112.148265] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[112.262316] [042/156] (908s left) gem_mmap_gtt (basic-write-gtt)
[112.311920] Subtest basic-write-gtt: SKIP (0.000s)
[112.369952] [043/156] (908s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[112.489151] Starting subtest: flip-vs-cursor-crc-atomic
[113.197039] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.704s)
[114.036250] [044/156] (907s left) i915_pm_freq_api (freq-basic-api)
[114.100976] Starting subtest: freq-basic-api
[114.103376] Starting dynamic subtest: gt0
[114.105693] Dynamic subtest gt0: SUCCESS (0.003s)
[114.115733] Starting dynamic subtest: gt1
[114.118032] Dynamic subtest gt1: SUCCESS (0.003s)
[114.120236] Subtest freq-basic-api: SUCCESS (0.006s)
[114.215087] [045/156] (906s left) gem_exercise_blt (fast-copy)
[114.277492] Starting subtest: fast-copy
[114.279842] Starting dynamic subtest: linear-smem-smem
[114.300253] Dynamic subtest linear-smem-smem: SUCCESS (0.022s)
[114.310974] Starting dynamic subtest: xmajor-smem-smem
[114.317834] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[114.326600] Starting dynamic subtest: tile4-smem-smem
[114.336994] Dynamic subtest tile4-smem-smem: SUCCESS (0.019s)
[114.345296] Starting dynamic subtest: tile64-smem-smem
[114.354973] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[114.357287] Subtest fast-copy: SUCCESS (0.077s)
[114.467958] [046/156] (906s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[114.569300] Starting subtest: psr-rgb565-draw-render
[121.660447] Subtest psr-rgb565-draw-render: SUCCESS (7.094s)
[121.775230] [047/156] (899s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[121.822045] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[121.824446] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[121.933924] [048/156] (899s left) gem_exec_params (no-bsd)
[121.995575] Starting subtest: no-bsd
[121.997845] Subtest no-bsd: SUCCESS (0.003s)
[123.357066] [049/156] (897s left) kms_pm_rpm (cursor)
[125.488886] Starting subtest: cursor
[125.493826] Subtest cursor: SKIP (0.000s)
[125.889466] [050/156] (895s left) kms_frontbuffer_tracking (fbchdr-indfb-scaledprimary)
[125.987788] Starting subtest: fbchdr-indfb-scaledprimary
[125.992102] Subtest fbchdr-indfb-scaledprimary: SKIP (0.000s)
[126.070516] [051/156] (895s left) perf (invalid-open-flags)
[126.202498] Starting subtest: invalid-open-flags
[126.204730] Subtest invalid-open-flags: SUCCESS (0.000s)
[126.256420] [052/156] (895s left) gem_lmem_swapping (verify-random)
[126.298570] Subtest verify-random: SKIP (0.000s)
[126.341852] [053/156] (895s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[126.436282] Starting subtest: plane-use-after-nonblocking-unbind
[126.438593] Starting dynamic subtest: pipe-A-eDP-1
[126.498706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[126.800856] Starting dynamic subtest: pipe-B-eDP-1
[127.588157] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.797s)
[127.886889] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.448s)
[128.735836] [054/156] (892s left) i915_drm_fdinfo (busy)
[128.781048] Starting subtest: busy
[128.783206] Starting dynamic subtest: rcs0
[128.815457] Dynamic subtest rcs0: SKIP (0.032s)
[128.826252] Starting dynamic subtest: bcs0
[128.830328] Dynamic subtest bcs0: SKIP (0.001s)
[128.839643] Starting dynamic subtest: vcs0
[128.844240] Dynamic subtest vcs0: SKIP (0.001s)
[128.855188] Starting dynamic subtest: vcs1
[128.859258] Dynamic subtest vcs1: SKIP (0.000s)
[128.867348] Starting dynamic subtest: vecs0
[128.871436] Dynamic subtest vecs0: SKIP (0.000s)
[128.879678] Starting dynamic subtest: ccs0
[128.883744] Dynamic subtest ccs0: SKIP (0.000s)
[128.887836] Subtest busy: SKIP (0.040s)
[128.927670] [055/156] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[129.029844] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[129.034252] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[129.138051] [056/156] (892s left) kms_flip (2x-flip-vs-suspend)
[129.236538] Starting subtest: 2x-flip-vs-suspend
[129.241623] Subtest 2x-flip-vs-suspend: SKIP (0.002s)
[129.313916] [057/156] (892s left) perf (invalid-oa-format-id)
[129.406127] Starting subtest: invalid-oa-format-id
[129.417346] Subtest invalid-oa-format-id: SUCCESS (0.010s)
[129.461142] [058/156] (892s left) api_intel_bb (add-remove-objects)
[129.516562] Starting subtest: add-remove-objects
[129.521590] Subtest add-remove-objects: SUCCESS (0.007s)
[129.631471] [059/156] (892s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[129.718014] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[129.720042] Starting dynamic subtest: pipe-A
[130.057335] Dynamic subtest pipe-A: SUCCESS (0.339s)
[130.066467] Starting dynamic subtest: pipe-B
[131.519888] Dynamic subtest pipe-B: SUCCESS (1.462s)
[131.528347] Starting dynamic subtest: pipe-C
[132.961577] Dynamic subtest pipe-C: SUCCESS (1.441s)
[132.971654] Starting dynamic subtest: pipe-D
[134.388923] Dynamic subtest pipe-D: SUCCESS (1.427s)
[134.391379] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.671s)
[135.574540] [060/156] (886s left) syncobj_wait (wait-any-interrupted)
[135.640526] Starting subtest: wait-any-interrupted
[135.748032] Subtest wait-any-interrupted: SUCCESS (0.106s)
[135.821809] [061/156] (885s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[135.944471] Starting subtest: basic-flip-after-cursor-atomic
[136.860043] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.916s)
[137.696041] [062/156] (884s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[137.755524] Starting subtest: yf-tiled-to-vebox-x-tiled
[137.760194] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[137.940129] [063/156] (883s left) i915_suspend (forcewake)
[137.991300] Starting subtest: forcewake
[172.043036] Subtest forcewake: SUCCESS (3.961s)
[180.145804] [064/156] (849s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[180.247370] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[180.249785] Starting dynamic subtest: pipe-A-eDP-1
[180.275564] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[180.286455] Starting dynamic subtest: pipe-B-eDP-1
[180.311456] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.320944] Starting dynamic subtest: pipe-C-eDP-1
[180.346134] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[180.355215] Starting dynamic subtest: pipe-D-eDP-1
[180.381019] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[180.385855] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[182.499552] [065/156] (847s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[182.600815] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[189.560924] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.096s)
[189.675587] [066/156] (840s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[189.784177] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[197.253905] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.531s)
[197.382955] [067/156] (832s left) kms_big_fb (x-tiled-addfb)
[197.486782] Starting subtest: x-tiled-addfb
[197.489468] Subtest x-tiled-addfb: SUCCESS (0.000s)
[197.585550] [068/156] (832s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[197.683090] Starting subtest: yf-tiled-64bpp-rotate-0
[197.687408] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[197.784971] [069/156] (832s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[197.908999] Starting subtest: cursor-vs-flip-toggle
[229.119551] Subtest cursor-vs-flip-toggle: SUCCESS (31.236s)
[229.988398] [070/156] (800s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt)
[230.096390] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt
[230.101344] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[230.193869] [071/156] (800s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[230.282632] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[230.285094] Starting dynamic subtest: pipe-A-eDP-1
[264.324174] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.663s)
[264.334434] Starting dynamic subtest: pipe-B-eDP-1
[299.261830] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.558s)
[299.272470] Starting dynamic subtest: pipe-C-eDP-1
[334.232808] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.533s)
[334.242521] Starting dynamic subtest: pipe-D-eDP-1
[369.226188] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.424s)
[369.228691] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.184s)
[376.478294] [072/156] (659s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[376.595996] Starting subtest: hdr-rgb565-draw-render
[376.600128] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[376.692743] [073/156] (659s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[376.795706] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[376.799886] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[376.895824] [074/156] (659s left) syncobj_timeline (wait-all-interrupted)
[376.957157] Starting subtest: wait-all-interrupted
[377.060192] Subtest wait-all-interrupted: SUCCESS (0.107s)
[377.134882] [075/156] (659s left) gem_exec_whisper (basic-contexts)
[377.187425] Starting subtest: basic-contexts
[383.138658] Subtest basic-contexts: SUCCESS (6.089s)
[383.322341] [076/156] (653s left) kms_content_protection (atomic-hdcp14)
[383.468177] Starting subtest: atomic-hdcp14
[383.472663] Subtest atomic-hdcp14: SKIP (0.000s)
[383.585167] [077/156] (652s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[383.687299] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[383.691253] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[383.795894] [078/156] (652s left) kms_cursor_edge_walk (128x128-left-edge)
[383.886273] Starting subtest: 128x128-left-edge
[383.888517] Starting dynamic subtest: pipe-A-eDP-1
[387.312334] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s)
[387.322395] Starting dynamic subtest: pipe-D-eDP-1
[390.434287] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.142s)
[390.436225] Subtest 128x128-left-edge: SUCCESS (6.610s)
[391.241359] [079/156] (645s left) gem_ctx_bad_destroy (invalid-pad)
[391.300311] Starting subtest: invalid-pad
[391.303155] Subtest invalid-pad: SUCCESS (0.000s)
[391.375751] [080/156] (645s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[391.470371] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[391.474647] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[391.550407] [081/156] (645s left) perf_pmu (rc6)
[391.587430] Starting subtest: rc6
[391.589362] Starting dynamic subtest: gt0
[397.957263] Dynamic subtest gt0: SUCCESS (6.392s)
[397.969173] Starting dynamic subtest: runtime-pm-gt0
[405.739710] Dynamic subtest runtime-pm-gt0: SUCCESS (7.794s)
[405.752784] Starting dynamic subtest: runtime-pm-long-gt0
[418.218452] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.472s)
[418.229737] Starting dynamic subtest: other-idle-gt0
[424.563922] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[424.578313] Starting dynamic subtest: gt1
[430.905999] Dynamic subtest gt1: SUCCESS (6.339s)
[430.920395] Starting dynamic subtest: runtime-pm-gt1
[438.337023] Dynamic subtest runtime-pm-gt1: SUCCESS (7.427s)
[438.350480] Starting dynamic subtest: runtime-pm-long-gt1
[450.842668] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.505s)
[450.856174] Starting dynamic subtest: other-idle-gt1
[457.185309] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[457.188433] Subtest rc6: SUCCESS (65.634s)
[458.353791] [082/156] (578s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[458.452862] Starting subtest: pr-overlay-plane-update-continuous-sf
[458.457114] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[458.499546] [083/156] (578s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt)
[458.586306] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt
[458.589604] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[458.660393] [084/156] (578s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[458.767245] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[458.770648] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[458.833748] [085/156] (578s left) perf_pmu (gt-awake)
[458.870050] Starting subtest: gt-awake
[467.219038] Subtest gt-awake: SUCCESS (8.350s)
[467.297338] [086/156] (569s left) kms_vblank (ts-continuation-dpms-suspend)
[467.385516] Starting subtest: ts-continuation-dpms-suspend
[467.387441] Starting dynamic subtest: pipe-A-eDP-1
[485.632172] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.296s)
[485.647404] Starting dynamic subtest: pipe-D-eDP-1
[503.623418] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.893s)
[503.626514] Subtest ts-continuation-dpms-suspend: SUCCESS (5.193s)
[508.431233] [087/156] (532s left) gem_flink_basic (flink-lifetime)
[508.483689] Starting subtest: flink-lifetime
[508.486543] Subtest flink-lifetime: SUCCESS (0.002s)
[508.564905] [088/156] (532s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[508.666347] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[508.671520] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[508.768296] [089/156] (532s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[508.851289] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[508.854016] Starting dynamic subtest: pipe-A-eDP-1
[508.878345] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[508.889536] Starting dynamic subtest: pipe-B-eDP-1
[508.920737] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[508.932543] Starting dynamic subtest: pipe-C-eDP-1
[508.957153] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[508.967312] Starting dynamic subtest: pipe-D-eDP-1
[508.991803] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[508.996765] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[511.041608] [090/156] (530s left) core_setmaster (master-drop-set-root)
[511.082312] Starting subtest: master-drop-set-root
[511.092511] Subtest master-drop-set-root: SUCCESS (0.012s)
[511.141489] [091/156] (530s left) kms_plane_multiple (2x-tiling-y)
[511.234271] Starting subtest: 2x-tiling-y
[511.239375] Subtest 2x-tiling-y: SKIP (0.000s)
[511.285464] [092/156] (529s left) i915_query (query-topology-matches-eu-total)
[511.339553] Starting subtest: query-topology-matches-eu-total
[511.342348] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[511.422830] [093/156] (529s left) gem_ctx_freq (sysfs)
[511.481418] Starting subtest: sysfs
[511.484118] Starting dynamic subtest: gt0
[516.988960] Dynamic subtest gt0: SUCCESS (5.616s)
[517.000417] Starting dynamic subtest: gt1
[558.232054] Dynamic subtest gt1: SUCCESS (41.335s)
[558.235359] Subtest sysfs: SUCCESS (46.955s)
[558.327907] [094/156] (482s left) kms_psr (psr-cursor-blt)
[558.434246] Starting subtest: psr-cursor-blt
[558.436774] Starting dynamic subtest: eDP-1
[560.147384] Dynamic subtest eDP-1: SUCCESS (1.714s)
[560.150374] Subtest psr-cursor-blt: SUCCESS (1.715s)
[560.996716] [095/156] (480s left) kms_draw_crc (draw-method-mmap-gtt)
[561.084356] Starting subtest: draw-method-mmap-gtt
[561.089782] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[561.164959] [096/156] (480s left) kms_dirtyfb (default-dirtyfb-ioctl)
[561.256284] Starting subtest: default-dirtyfb-ioctl
[561.259037] Starting dynamic subtest: A-eDP-1
[562.863254] Dynamic subtest A-eDP-1: SUCCESS (1.608s)
[562.866174] Subtest default-dirtyfb-ioctl: SUCCESS (1.609s)
[563.735851] [097/156] (477s left) template (a)
[563.793393] Starting subtest: A
[563.796212] Subtest A: SUCCESS (0.000s)
[563.867500] [098/156] (477s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[563.971779] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[563.976406] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[564.042227] [099/156] (477s left) kms_sequence (queue-busy)
[564.128862] Starting subtest: queue-busy
[564.131560] Starting dynamic subtest: pipe-A-eDP-1
[566.068257] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.938s)
[566.079235] Starting dynamic subtest: pipe-B-eDP-1
[568.675010] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.609s)
[568.686556] Starting dynamic subtest: pipe-C-eDP-1
[571.277252] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[571.288007] Starting dynamic subtest: pipe-D-eDP-1
[573.896258] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[573.898565] Subtest queue-busy: SUCCESS (9.770s)
[574.771071] [100/156] (466s left) gem_create (create-ext-placement-all)
[574.944538] Starting subtest: create-ext-placement-all
[574.947403] Subtest create-ext-placement-all: SUCCESS (0.000s)
[575.030149] [101/156] (466s left) kms_invalid_mode (zero-clock)
[575.130474] Starting subtest: zero-clock
[575.133273] Starting dynamic subtest: pipe-A-eDP-1
[575.430685] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.303s)
[575.441785] Starting dynamic subtest: pipe-B-eDP-1
[575.444095] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[575.454691] Starting dynamic subtest: pipe-C-eDP-1
[575.457353] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[575.467551] Starting dynamic subtest: pipe-D-eDP-1
[575.470367] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[575.472797] Subtest zero-clock: SUCCESS (0.309s)
[576.224016] [102/156] (465s left) kms_async_flips (invalid-async-flip-atomic)
[576.319404] Starting subtest: invalid-async-flip-atomic
[576.702121] Starting dynamic subtest: pipe-A-eDP-1
[577.578749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.878s)
[577.944846] Starting dynamic subtest: pipe-B-eDP-1
[578.818243] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.884s)
[579.173184] Starting dynamic subtest: pipe-C-eDP-1
[580.040180] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.876s)
[580.401169] Starting dynamic subtest: pipe-D-eDP-1
[581.272079] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.881s)
[581.274664] Subtest invalid-async-flip-atomic: SUCCESS (4.957s)
[582.497935] [103/156] (459s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[582.599296] Starting subtest: y-tiled-16bpp-rotate-180
[582.604530] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[582.675135] [104/156] (459s left) gem_exec_schedule (smoketest)
[582.854541] Starting subtest: smoketest
[582.857313] Starting dynamic subtest: rcs0
[588.420916] Dynamic subtest rcs0: SUCCESS (5.507s)
[588.433254] Starting dynamic subtest: bcs0
[593.966476] Dynamic subtest bcs0: SUCCESS (5.541s)
[593.984512] Starting dynamic subtest: vcs0
[599.474126] Dynamic subtest vcs0: SUCCESS (5.505s)
[599.490349] Starting dynamic subtest: vcs1
[604.981864] Dynamic subtest vcs1: SUCCESS (5.515s)
[604.995897] Starting dynamic subtest: vecs0
[610.497336] Dynamic subtest vecs0: SUCCESS (5.511s)
[610.510009] Starting dynamic subtest: ccs0
[616.018305] Dynamic subtest ccs0: SUCCESS (5.520s)
[616.020416] Subtest smoketest: SUCCESS (33.106s)
[616.166882] [105/156] (425s left) kms_addfb_basic (addfb25-4-tiled)
[616.270548] Starting subtest: addfb25-4-tiled
[616.273104] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[616.353945] [106/156] (425s left) drm_read (fault-buffer)
[616.499531] Starting subtest: fault-buffer
[616.502126] Subtest fault-buffer: SUCCESS (0.000s)
[616.603586] [107/156] (425s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[616.697291] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[616.702132] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[617.838272] [108/156] (424s left) kms_force_connector_basic (force-connector-state)
[617.919505] Starting subtest: force-connector-state
[618.546015] Subtest force-connector-state: SUCCESS (0.626s)
[619.482996] [109/156] (422s left) gem_pread (exhaustion)
[619.538238] Subtest exhaustion: SKIP (0.000s)
[619.602066] [110/156] (422s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[619.709028] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[619.714002] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[619.777798] [111/156] (422s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[620.022217] Starting subtest: cursor-rapid-movement-256x256
[620.028428] Starting dynamic subtest: pipe-A-eDP-1
[620.584519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s)
[620.614525] Starting dynamic subtest: pipe-D-eDP-1
[621.764608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.157s)
[621.767324] Subtest cursor-rapid-movement-256x256: SUCCESS (1.742s)
[622.558303] [112/156] (419s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[622.647238] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[622.649556] Starting dynamic subtest: pipe-A
[622.708164] Dynamic subtest pipe-A: SUCCESS (0.064s)
[622.719401] Starting dynamic subtest: pipe-B
[623.866260] Dynamic subtest pipe-B: SUCCESS (1.158s)
[623.878170] Starting dynamic subtest: pipe-C
[625.046732] Dynamic subtest pipe-C: SUCCESS (1.178s)
[625.057341] Starting dynamic subtest: pipe-D
[626.142331] Dynamic subtest pipe-D: SUCCESS (1.095s)
[626.145221] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.499s)
[627.371106] [113/156] (414s left) kms_lease (lessee-list)
[627.454277] Starting subtest: lessee-list
[627.457114] Starting dynamic subtest: pipe-A-eDP-1
[627.459967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[627.470472] Starting dynamic subtest: pipe-B-eDP-1
[627.472849] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[627.483104] Starting dynamic subtest: pipe-C-eDP-1
[627.485368] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[627.495312] Starting dynamic subtest: pipe-D-eDP-1
[627.497409] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[627.499408] Subtest lessee-list: SUCCESS (0.009s)
[627.541055] [114/156] (414s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[627.635295] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[627.640300] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[627.695756] [115/156] (414s left) gem_exec_balancer (parallel-bb-first)
[627.945217] Starting subtest: parallel-bb-first
[628.923266] Subtest parallel-bb-first: SUCCESS (0.978s)
[629.233845] [116/156] (413s left) gem_tiled_blits (basic)
[629.290529] Subtest basic: SKIP (0.000s)
[629.370171] [117/156] (412s left) kms_psr (pr-cursor-plane-onoff)
[629.458406] Starting subtest: pr-cursor-plane-onoff
[629.464309] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[629.511908] [118/156] (412s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[629.611284] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc
[629.616244] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[629.695195] [119/156] (412s left) fbdev (read)
[629.743215] Starting subtest: read
[630.478098] Subtest read: SUCCESS (0.734s)
[630.523345] [120/156] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[630.618317] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[630.623332] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[630.680630] [121/156] (411s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[630.786116] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[635.133203] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.354s)
[636.270008] [122/156] (406s left) kms_plane_alpha_blend (constant-alpha-mid)
[636.364373] Starting subtest: constant-alpha-mid
[636.654810] Starting dynamic subtest: pipe-A-eDP-1
[637.564337] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.909s)
[637.579333] Starting dynamic subtest: pipe-D-eDP-1
[639.072956] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.508s)
[639.075545] Subtest constant-alpha-mid: SUCCESS (2.711s)
[639.865266] [123/156] (402s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[639.971626] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[639.976455] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[640.049353] [124/156] (402s left) kms_flip (basic-plain-flip)
[640.137792] Starting subtest: basic-plain-flip
[640.140055] Starting dynamic subtest: A-eDP1
[641.846522] Dynamic subtest A-eDP1: SUCCESS (1.710s)
[641.863801] Starting dynamic subtest: B-eDP1
[643.554133] Dynamic subtest B-eDP1: SUCCESS (1.704s)
[643.566378] Starting dynamic subtest: C-eDP1
[645.250762] Dynamic subtest C-eDP1: SUCCESS (1.696s)
[645.262343] Starting dynamic subtest: D-eDP1
[646.941194] Dynamic subtest D-eDP1: SUCCESS (1.689s)
[646.947370] Subtest basic-plain-flip: SUCCESS (6.813s)
[648.160452] [125/156] (394s left) kms_chamelium_frames (vga-frame-dump)
[648.542134] Subtest vga-frame-dump: SKIP (0.000s)
[649.370695] [126/156] (393s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[649.467339] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[649.472541] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[649.552012] [127/156] (393s left) kms_psr (pr-basic)
[649.647124] Starting subtest: pr-basic
[649.652339] Subtest pr-basic: SKIP (0.000s)
[649.703736] [128/156] (393s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[650.091457] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[650.963127] [129/156] (391s left) api_intel_bb (object-reloc-keep-cache)
[651.014443] Starting subtest: object-reloc-keep-cache
[651.020259] Subtest object-reloc-keep-cache: SKIP (0.003s)
[651.080295] [130/156] (391s left) i915_pm_rps (basic-api)
[651.133254] Starting subtest: basic-api
[651.138547] Subtest basic-api: SKIP (0.001s)
[651.201600] [131/156] (391s left) gem_pxp (protected-raw-src-copy-not-readible)
[651.316581] Starting subtest: protected-raw-src-copy-not-readible
[651.374356] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[651.463276] [132/156] (391s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[651.563959] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[651.569147] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[651.633941] [133/156] (391s left) sysfs_preempt_timeout (timeout)
[651.691633] Starting subtest: timeout
[651.694433] Starting dynamic subtest: vecs0
[661.200665] Dynamic subtest vecs0: SUCCESS (9.507s)
[661.213053] Starting dynamic subtest: ccs0
[662.451193] Dynamic subtest ccs0: SUCCESS (1.251s)
[662.464720] Starting dynamic subtest: vcs0
[672.213182] Dynamic subtest vcs0: SUCCESS (9.759s)
[672.229498] Starting dynamic subtest: bcs0
[673.450296] Dynamic subtest bcs0: SUCCESS (1.237s)
[673.460881] Starting dynamic subtest: rcs0
[674.658966] Dynamic subtest rcs0: SUCCESS (1.207s)
[674.672106] Starting dynamic subtest: vcs1
[684.247034] Dynamic subtest vcs1: SUCCESS (9.584s)
[684.249551] Subtest timeout: SUCCESS (32.559s)
[684.303708] [134/156] (358s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[684.430178] Starting subtest: cursorB-vs-flipB-atomic-transitions
[684.434972] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[684.555288] [135/156] (358s left) kms_big_fb (linear-8bpp-rotate-90)
[684.660528] Starting subtest: linear-8bpp-rotate-90
[684.682305] Subtest linear-8bpp-rotate-90: SKIP (0.021s)
[684.767012] [136/156] (358s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[684.871162] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[684.876121] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[684.929887] [137/156] (358s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-pwrite)
[685.024791] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-pwrite
[685.029915] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[685.098237] [138/156] (358s left) gem_wait (write-wait)
[685.157574] Starting subtest: write-wait
[685.160264] Starting dynamic subtest: all-engines
[686.245238] Dynamic subtest all-engines: SUCCESS (1.087s)
[686.256571] Starting dynamic subtest: rcs0
[687.315778] Dynamic subtest rcs0: SUCCESS (1.068s)
[687.334643] Starting dynamic subtest: bcs0
[688.387995] Dynamic subtest bcs0: SUCCESS (1.069s)
[688.406854] Starting dynamic subtest: vcs0
[689.447260] Dynamic subtest vcs0: SUCCESS (1.059s)
[689.465304] Starting dynamic subtest: vcs1
[690.507670] Dynamic subtest vcs1: SUCCESS (1.058s)
[690.526118] Starting dynamic subtest: vecs0
[691.566680] Dynamic subtest vecs0: SUCCESS (1.056s)
[691.584759] Starting dynamic subtest: ccs0
[692.629915] Dynamic subtest ccs0: SUCCESS (1.061s)
[692.632757] Subtest write-wait: SUCCESS (7.475s)
[692.809407] [139/156] (350s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[692.910366] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[692.915307] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[692.958829] [140/156] (350s left) gem_exec_suspend (basic-s3)
[693.015231] Starting subtest: basic-S3
[693.018070] Starting dynamic subtest: smem
[713.611645] Dynamic subtest smem: SUCCESS (6.209s)
[713.614737] Subtest basic-S3: SUCCESS (6.210s)
[719.787589] [141/156] (329s left) kms_flip (blocking-wf_vblank)
[719.900031] Starting subtest: blocking-wf_vblank
[719.902198] Starting dynamic subtest: A-eDP1
[721.346216] Dynamic subtest A-eDP1: FAIL (1.370s)
[721.359186] Starting dynamic subtest: B-eDP1
[741.996845] Dynamic subtest B-eDP1: SUCCESS (20.969s)
[742.007744] Starting dynamic subtest: C-eDP1
[750.870769] Dynamic subtest C-eDP1: SUCCESS (8.892s)
[750.882318] Starting dynamic subtest: D-eDP1
[759.781391] Dynamic subtest D-eDP1: SUCCESS (8.905s)
[759.786978] Subtest blocking-wf_vblank: FAIL (40.148s)
[760.953035] [142/156] (288s left) kms_flip (2x-blocking-absolute-wf_vblank)
[761.051071] Starting subtest: 2x-blocking-absolute-wf_vblank
[761.062859] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[761.118325] [143/156] (288s left) gem_exec_schedule (independent)
[761.196530] Starting subtest: independent
[761.198873] Starting dynamic subtest: rcs0
[762.634646] Dynamic subtest rcs0: SUCCESS (1.446s)
[762.649289] Starting dynamic subtest: vcs0
[764.624197] Dynamic subtest vcs0: SUCCESS (1.987s)
[764.636186] Starting dynamic subtest: vcs1
[766.629156] Dynamic subtest vcs1: SUCCESS (2.002s)
[766.641137] Starting dynamic subtest: vecs0
[768.595566] Dynamic subtest vecs0: SUCCESS (1.964s)
[768.609002] Starting dynamic subtest: ccs0
[770.634778] Dynamic subtest ccs0: SUCCESS (2.036s)
[770.637412] Subtest independent: SUCCESS (9.447s)
[770.918410] [144/156] (278s left) prime_busy (hang-wait)
[770.976526] Starting subtest: hang-wait
[770.978860] Starting dynamic subtest: rcs0
[797.094541] Dynamic subtest rcs0: SUCCESS (26.119s)
[797.105688] Starting dynamic subtest: bcs0
[804.251763] Dynamic subtest bcs0: SUCCESS (7.155s)
[804.264021] Starting dynamic subtest: vcs0
[811.289374] Dynamic subtest vcs0: SUCCESS (7.040s)
[811.299966] Starting dynamic subtest: vcs1
[818.266670] Dynamic subtest vcs1: SUCCESS (6.975s)
[818.278704] Starting dynamic subtest: vecs0
[825.235699] Dynamic subtest vecs0: SUCCESS (6.967s)
[825.248623] Starting dynamic subtest: ccs0
[839.140843] Dynamic subtest ccs0: SUCCESS (13.898s)
[839.142934] Subtest hang-wait: SUCCESS (68.169s)
[839.260526] [145/156] (210s left) perf_pmu (busy-accuracy-98)
[839.306580] Starting subtest: busy-accuracy-98
[839.308891] Starting dynamic subtest: rcs0
[842.352644] Dynamic subtest rcs0: SUCCESS (3.045s)
[842.369612] Starting dynamic subtest: bcs0
[845.406755] Dynamic subtest bcs0: SUCCESS (3.050s)
[845.420267] Starting dynamic subtest: vcs0
[848.450590] Dynamic subtest vcs0: SUCCESS (3.043s)
[848.463544] Starting dynamic subtest: vcs1
[851.493540] Dynamic subtest vcs1: SUCCESS (3.040s)
[851.504787] Starting dynamic subtest: vecs0
[854.531723] Dynamic subtest vecs0: SUCCESS (3.036s)
[854.544661] Starting dynamic subtest: ccs0
[857.584108] Dynamic subtest ccs0: SUCCESS (3.050s)
[857.586679] Subtest busy-accuracy-98: SUCCESS (18.277s)
[857.680581] [146/156] (191s left) gem_exec_basic (basic)
[857.736931] Starting subtest: basic
[857.739261] Starting dynamic subtest: rcs0-smem
[857.741631] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[857.753627] Starting dynamic subtest: bcs0-smem
[857.755921] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[857.766879] Starting dynamic subtest: vcs0-smem
[857.769017] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[857.780274] Starting dynamic subtest: vcs1-smem
[857.782405] Dynamic subtest vcs1-smem: SUCCESS (0.004s)
[857.793380] Starting dynamic subtest: vecs0-smem
[857.795526] Dynamic subtest vecs0-smem: SUCCESS (0.005s)
[857.805594] Starting dynamic subtest: ccs0-smem
[857.807806] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[857.810028] Subtest basic: SUCCESS (0.024s)
[859.612992] [147/156] (190s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[859.705950] Starting subtest: fbc-pr-sprite-mmap-cpu
[859.710771] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[859.760716] [148/156] (189s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[859.861327] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[859.865585] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[859.944758] [149/156] (189s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[860.048569] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[860.050883] Starting dynamic subtest: pipe-A-default-mode
[861.201913] Dynamic subtest pipe-A-default-mode: SKIP (1.150s)
[861.206537] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.151s)
[861.324689] [150/156] (188s left) kms_setmode (basic)
[861.377447] Starting subtest: basic
[861.702477] Starting dynamic subtest: pipe-A-eDP-1
[863.843868] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.137s)
[864.191109] Starting dynamic subtest: pipe-B-eDP-1
[866.251130] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.068s)
[866.566651] Subtest basic: SUCCESS (5.188s)
[867.363433] [151/156] (182s left) prime_self_import (basic-llseek-size)
[867.402035] Starting subtest: basic-llseek-size
[867.413338] Subtest basic-llseek-size: SUCCESS (0.015s)
[867.494393] [152/156] (182s left) kms_scaling_modes (scaling-mode-center)
[867.590030] Starting subtest: scaling-mode-center
[867.591885] Starting dynamic subtest: pipe-A-eDP-1
[867.682201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[867.693352] Starting dynamic subtest: pipe-B-eDP-1
[868.851335] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.168s)
[868.863855] Starting dynamic subtest: pipe-C-eDP-1
[870.042933] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.189s)
[870.056102] Starting dynamic subtest: pipe-D-eDP-1
[871.229608] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.185s)
[871.231860] Subtest scaling-mode-center: SUCCESS (3.643s)
[872.441133] [153/156] (177s left) kms_cursor_crc (cursor-onscreen-max-size)
[872.733719] Starting subtest: cursor-onscreen-max-size
[872.740435] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[872.832627] [154/156] (177s left) gem_exec_reloc (basic-cpu-read-noreloc)
[872.897416] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[872.975772] [155/156] (176s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt)
[873.076792] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt
[873.080905] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[873.149254] [156/156] (176s left) kms_pm_rpm (modeset-pc8-residency-stress)
[874.770790] Starting subtest: modeset-pc8-residency-stress
[874.777515] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[875.441815] Closing watchdogs
results: parsing output: 0/ for test: gem_workarounds
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: gem_exec_async
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_color
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_exec_parallel
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_fence_thrash
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: kms_properties
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_chamelium_color
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: i915_pm_freq_api
results: parsing output: 44/ for test: gem_exercise_blt
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: kms_atomic_transition
results: parsing output: 53/ for test: i915_drm_fdinfo
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: perf
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: gem_render_copy
results: parsing output: 62/ for test: i915_suspend
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: kms_content_protection
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_edge_walk
results: parsing output: 78/ for test: gem_ctx_bad_destroy
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_vblank
results: parsing output: 86/ for test: gem_flink_basic
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: core_setmaster
results: parsing output: 90/ for test: kms_plane_multiple
results: parsing output: 91/ for test: i915_query
results: parsing output: 92/ for test: gem_ctx_freq
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_draw_crc
results: parsing output: 95/ for test: kms_dirtyfb
results: parsing output: 96/ for test: template
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_sequence
results: parsing output: 99/ for test: gem_create
results: parsing output: 100/ for test: kms_invalid_mode
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: drm_read
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: kms_force_connector_basic
results: parsing output: 108/ for test: gem_pread
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_lease
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: gem_tiled_blits
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: fbdev
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_plane_alpha_blend
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_chamelium_frames
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_chamelium_hpd
results: parsing output: 128/ for test: api_intel_bb
results: parsing output: 129/ for test: i915_pm_rps
results: parsing output: 130/ for test: gem_pxp
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: sysfs_preempt_timeout
results: parsing output: 133/ for test: kms_cursor_legacy
results: parsing output: 134/ for test: kms_big_fb
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_wait
results: parsing output: 138/ for test: kms_psr2_sf
results: parsing output: 139/ for test: gem_exec_suspend
results: parsing output: 140/ for test: kms_flip
results: parsing output: 141/ for test: kms_flip
results: parsing output: 142/ for test: gem_exec_schedule
results: parsing output: 143/ for test: prime_busy
results: parsing output: 144/ for test: perf_pmu
results: parsing output: 145/ for test: gem_exec_basic
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_flip_scaled_crc
results: parsing output: 149/ for test: kms_setmode
results: parsing output: 150/ for test: prime_self_import
results: parsing output: 151/ for test: kms_scaling_modes
results: parsing output: 152/ for test: kms_cursor_crc
results: parsing output: 153/ for test: gem_exec_reloc
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_pm_rpm
Done.