[55.180659] Initializing watchdogs
[55.180748]   /dev/watchdog0
[55.194688] [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]
[55.198854] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.201096] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.202783] [001/131] (960s left) gen9_exec_parse (bb-start-far)
[55.264102] Subtest bb-start-far: SKIP (0.000s)
[55.319719] [002/131] (960s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[55.694958] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[56.501238] [003/131] (959s left) gem_exec_fence (syncobj-import)
[56.932511] Starting subtest: syncobj-import
[56.937209] Subtest syncobj-import: SUCCESS (0.005s)
[58.008037] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[58.009679] [004/131] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[58.101326] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[58.103041] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[58.198186] [005/131] (957s left) gem_exec_fence (syncobj-repeat)
[58.598734] Starting subtest: syncobj-repeat
[58.782805] Subtest syncobj-repeat: SUCCESS (0.186s)
[60.003983] [006/131] (955s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[60.088622] Starting subtest: plane-upscale-20x20-with-modifiers
[60.089621] Starting dynamic subtest: pipe-A
[60.423881] Dynamic subtest pipe-A: SUCCESS (0.339s)
[60.430732] Starting dynamic subtest: pipe-B
[61.836561] Dynamic subtest pipe-B: SUCCESS (1.429s)
[61.846263] Starting dynamic subtest: pipe-C
[63.246069] Dynamic subtest pipe-C: SUCCESS (1.423s)
[63.261973] Starting dynamic subtest: pipe-D
[64.661636] Dynamic subtest pipe-D: SUCCESS (1.426s)
[64.662690] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.619s)
[65.810648] [007/131] (950s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[65.934878] Starting subtest: cursorB-vs-flipA-toggle
[65.937591] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[66.060350] [008/131] (949s left) kms_joiner (basic-force-ultra-joiner)
[66.156422] Starting subtest: basic-force-ultra-joiner
[66.158261] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[66.216285] [009/131] (949s left) gem_ctx_exec (basic)
[66.272500] Starting subtest: basic
[66.283114] Subtest basic: SUCCESS (0.010s)
[66.391586] [010/131] (949s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[66.449108] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[66.555410] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[66.629487] [011/131] (949s left) kms_addfb_basic (unused-offsets)
[66.674509] Starting subtest: unused-offsets
[66.675656] Subtest unused-offsets: SUCCESS (0.000s)
[66.796175] [012/131] (949s left) gem_pread (self)
[66.847076] Subtest self: SKIP (0.000s)
[66.907885] [013/131] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[66.997058] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[66.998870] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[67.086041] [014/131] (949s left) kms_properties (connector-properties-atomic)
[67.172877] Starting subtest: connector-properties-atomic
[67.173887] Starting dynamic subtest: pipe-A-eDP-1
[74.903894] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.755s)
[74.910517] Starting dynamic subtest: pipe-None-DP-1
[74.912318] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[74.917781] Starting dynamic subtest: pipe-None-HDMI-A-1
[74.919628] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[74.924970] Starting dynamic subtest: pipe-None-DP-2
[74.926810] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[74.932679] Starting dynamic subtest: pipe-None-HDMI-A-2
[74.934809] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[74.942237] Starting dynamic subtest: pipe-None-DP-3
[74.944031] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[74.949455] Starting dynamic subtest: pipe-None-DP-4
[74.951317] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[74.952272] Subtest connector-properties-atomic: SUCCESS (7.763s)
[75.760199] [015/131] (940s left) gem_mmap (basic-small-bo)
[75.827837] Subtest basic-small-bo: SKIP (0.000s)
[75.893128] [016/131] (940s left) kms_pm_rpm (basic-rte)
[75.917620] Starting subtest: basic-rte
[79.555829] Subtest basic-rte: SUCCESS (3.643s)
[81.321786] [017/131] (934s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[81.384186] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[81.440226] [018/131] (934s left) gem_ctx_param (invalid-ctx-set)
[81.481088] Starting subtest: invalid-ctx-set
[81.482039] Subtest invalid-ctx-set: SUCCESS (0.001s)
[81.585758] [019/131] (934s left) kms_plane_cursor (primary)
[81.680636] Starting subtest: primary
[81.682737] Starting dynamic subtest: pipe-A-eDP-1-size-64
[84.456123] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.771s)
[84.480724] Starting dynamic subtest: pipe-A-eDP-1-size-128
[87.271953] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.794s)
[87.295495] Starting dynamic subtest: pipe-A-eDP-1-size-256
[90.053477] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.760s)
[90.363564] Starting dynamic subtest: pipe-B-eDP-1-size-64
[93.787941] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.427s)
[93.811173] Starting dynamic subtest: pipe-B-eDP-1-size-128
[96.557216] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.749s)
[96.582061] Starting dynamic subtest: pipe-B-eDP-1-size-256
[99.337903] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.760s)
[99.649632] Starting dynamic subtest: pipe-C-eDP-1-size-64
[102.750842] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.108s)
[102.776157] Starting dynamic subtest: pipe-C-eDP-1-size-128
[105.218785] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.447s)
[105.244153] Starting dynamic subtest: pipe-C-eDP-1-size-256
[107.631873] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.391s)
[107.944388] Starting dynamic subtest: pipe-D-eDP-1-size-64
[111.017363] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.078s)
[111.043622] Starting dynamic subtest: pipe-D-eDP-1-size-128
[113.452147] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.412s)
[113.478287] Starting dynamic subtest: pipe-D-eDP-1-size-256
[115.897394] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.424s)
[116.203441] Subtest primary: SUCCESS (34.495s)
[117.031422] [020/131] (899s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[117.128789] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[123.785928] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.657s)
[123.936571] [021/131] (892s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[124.050616] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[125.342798] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.292s)
[125.631209] [022/131] (890s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[125.749620] Starting subtest: cursor-vs-flip-varying-size
[156.155375] Subtest cursor-vs-flip-varying-size: SUCCESS (30.406s)
[156.947274] [023/131] (859s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[157.049950] Starting subtest: psr-2p-primscrn-cur-indfb-move
[157.051582] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[157.166203] [024/131] (859s left) gem_spin_batch (resubmit-new-all)
[157.221143] Starting subtest: resubmit-new-all
[157.222357] Starting dynamic subtest: rcs0
[157.237676] Dynamic subtest rcs0: SUCCESS (0.015s)
[157.245506] Starting dynamic subtest: bcs0
[157.248046] Dynamic subtest bcs0: SUCCESS (0.010s)
[157.253829] Starting dynamic subtest: vcs0
[157.256053] Dynamic subtest vcs0: SUCCESS (0.009s)
[157.263634] Starting dynamic subtest: vcs1
[157.266961] Dynamic subtest vcs1: SUCCESS (0.010s)
[157.274028] Starting dynamic subtest: vecs0
[157.276097] Dynamic subtest vecs0: SUCCESS (0.009s)
[157.281889] Starting dynamic subtest: ccs0
[157.283976] Dynamic subtest ccs0: SUCCESS (0.008s)
[157.284860] Subtest resubmit-new-all: SUCCESS (0.063s)
[158.974114] [025/131] (857s left) i915_suspend (basic-s2idle-without-i915)
[159.006997] Starting subtest: basic-s2idle-without-i915
[179.394948] Subtest basic-s2idle-without-i915: SUCCESS (4.564s)
[184.515074] [026/131] (836s left) kms_psr (fbc-psr-suspend)
[184.613498] Starting subtest: fbc-psr-suspend
[184.614537] Starting dynamic subtest: eDP-1
[184.616258] Dynamic subtest eDP-1: SKIP (0.000s)
[184.617912] Subtest fbc-psr-suspend: SKIP (0.001s)
[184.674960] [027/131] (836s left) prime_mmap (test_map_unmap)
[184.725448] Starting subtest: test_map_unmap
[184.726501] Starting dynamic subtest: test_map_unmap-smem
[184.759392] Dynamic subtest test_map_unmap-smem: SUCCESS (0.035s)
[184.760548] Subtest test_map_unmap: SUCCESS (0.036s)
[184.846490] [028/131] (836s left) syncobj_wait (multi-wait-signaled)
[184.890426] Starting subtest: multi-wait-signaled
[184.891364] Subtest multi-wait-signaled: SUCCESS (0.000s)
[184.968046] [029/131] (836s left) gem_ctx_param (basic)
[185.008666] Starting subtest: basic
[185.010869] Subtest basic: SUCCESS (0.002s)
[185.110657] [030/131] (836s left) gem_unfence_active_buffers
[185.262447] [031/131] (836s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[185.352640] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[192.060981] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (6.889s)
[192.210827] [032/131] (829s left) prime_mmap (test_userptr)
[192.265845] Starting subtest: test_userptr
[192.268073] Starting dynamic subtest: test_userptr-smem
[192.268923] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[192.269768] Subtest test_userptr: SUCCESS (0.003s)
[192.379952] [033/131] (829s left) kms_lease (atomic-implicit-crtc)
[192.467157] Starting subtest: atomic-implicit-crtc
[192.468258] Starting dynamic subtest: pipe-A-eDP-1
[192.473027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[192.479493] Starting dynamic subtest: pipe-B-eDP-1
[192.483529] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[192.490017] Starting dynamic subtest: pipe-C-eDP-1
[192.494252] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[192.500619] Starting dynamic subtest: pipe-D-eDP-1
[192.504668] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[192.505519] Subtest atomic-implicit-crtc: SUCCESS (0.030s)
[192.601424] [034/131] (829s left) kms_psr (fbc-pr-dpms)
[192.700843] Starting subtest: fbc-pr-dpms
[192.702760] Subtest fbc-pr-dpms: SKIP (0.000s)
[192.765084] [035/131] (829s left) gem_exec_reloc (basic-cpu-read-active)
[192.817407] Subtest basic-cpu-read-active: SKIP (0.000s)
[192.884534] [036/131] (828s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[192.986519] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[192.988074] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[193.073376] [037/131] (828s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[193.166586] Starting subtest: x-tiled-16bpp-rotate-90
[193.187251] Subtest x-tiled-16bpp-rotate-90: SKIP (0.021s)
[193.303713] [038/131] (828s left) i915_drm_fdinfo (most-busy-check-all)
[193.334662] Starting subtest: most-busy-check-all
[193.335806] Starting dynamic subtest: rcs0
[193.339822] Dynamic subtest rcs0: SKIP (0.004s)
[193.347078] Starting dynamic subtest: bcs0
[193.348965] Dynamic subtest bcs0: SKIP (0.000s)
[193.355663] Starting dynamic subtest: vcs0
[193.357420] Dynamic subtest vcs0: SKIP (0.000s)
[193.364049] Starting dynamic subtest: vcs1
[193.366040] Dynamic subtest vcs1: SKIP (0.000s)
[193.374450] Starting dynamic subtest: vecs0
[193.376213] Dynamic subtest vecs0: SKIP (0.000s)
[193.382440] Starting dynamic subtest: ccs0
[193.384186] Dynamic subtest ccs0: SKIP (0.000s)
[193.386083] Subtest most-busy-check-all: SKIP (0.008s)
[193.413306] [039/131] (828s left) gem_ctx_sseu (mmap-args)
[193.505507] Subtest mmap-args: SKIP (0.000s)
[193.570854] [040/131] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[193.664743] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[193.666355] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[193.762246] [041/131] (828s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[193.855265] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[193.856937] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[193.962165] [042/131] (828s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[194.040886] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[194.041770] Starting dynamic subtest: pipe-A-eDP-1
[194.049913] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.056456] Starting dynamic subtest: pipe-B-eDP-1
[194.064679] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.071288] Starting dynamic subtest: pipe-C-eDP-1
[194.079353] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.085757] Starting dynamic subtest: pipe-D-eDP-1
[194.094031] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.095670] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[196.269683] [043/131] (825s left) kms_draw_crc (draw-method-render)
[196.354772] Starting subtest: draw-method-render
[196.355725] Starting dynamic subtest: xrgb8888-untiled
[196.603392] Dynamic subtest xrgb8888-untiled: SUCCESS (0.252s)
[196.611241] Starting dynamic subtest: rgb565-untiled
[196.812787] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[196.819834] Starting dynamic subtest: xrgb2101010-untiled
[197.010982] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[197.018829] Starting dynamic subtest: xbgr16161616f-untiled
[197.264181] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.255s)
[197.272312] Starting dynamic subtest: xrgb8888-xtiled
[197.385361] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.120s)
[197.392698] Starting dynamic subtest: rgb565-xtiled
[197.495755] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[197.502493] Starting dynamic subtest: xrgb2101010-xtiled
[197.616776] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[197.624187] Starting dynamic subtest: xbgr16161616f-xtiled
[197.760339] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.144s)
[197.768380] Starting dynamic subtest: xrgb8888-4tiled
[197.881407] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.120s)
[197.894283] Starting dynamic subtest: rgb565-4tiled
[197.991610] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[197.998307] Starting dynamic subtest: xrgb2101010-4tiled
[198.101901] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[198.109297] Starting dynamic subtest: xbgr16161616f-4tiled
[198.256135] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s)
[198.257034] Subtest draw-method-render: SUCCESS (1.919s)
[198.366899] [044/131] (823s left) kms_setmode (basic)
[198.422458] Starting subtest: basic
[198.748847] Starting dynamic subtest: pipe-A-eDP-1
[200.902843] Dynamic subtest pipe-A-eDP-1: FAIL (2.129s)
[201.214489] Starting dynamic subtest: pipe-B-eDP-1
[203.315289] Dynamic subtest pipe-B-eDP-1: FAIL (2.075s)
[203.573479] Subtest basic: FAIL (5.179s)
[204.394476] [045/131] (817s left) syncobj_timeline (single-wait-all-available-signaled)
[204.442967] Starting subtest: single-wait-all-available-signaled
[204.443819] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[204.517696] [046/131] (817s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[204.573398] Starting subtest: y-tiled-to-vebox-yf-tiled
[204.575038] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[204.748255] [047/131] (817s left) syncobj_basic (bad-fd-to-handle)
[204.794470] Starting subtest: bad-fd-to-handle
[204.795465] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[204.900448] [048/131] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[204.984504] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[211.689191] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.724s)
[211.828461] [049/131] (810s left) gem_exec_schedule (preempt-contexts)
[211.878140] Starting subtest: preempt-contexts
[211.879012] Starting dynamic subtest: rcs0
[211.933830] Dynamic subtest rcs0: SUCCESS (0.055s)
[211.941523] Starting dynamic subtest: bcs0
[211.981812] Dynamic subtest bcs0: SUCCESS (0.047s)
[211.989027] Starting dynamic subtest: vcs0
[212.028642] Dynamic subtest vcs0: SUCCESS (0.046s)
[212.035556] Starting dynamic subtest: vcs1
[212.069533] Dynamic subtest vcs1: SUCCESS (0.040s)
[212.077574] Starting dynamic subtest: vecs0
[212.112215] Dynamic subtest vecs0: SUCCESS (0.042s)
[212.119718] Starting dynamic subtest: ccs0
[212.157307] Dynamic subtest ccs0: SUCCESS (0.045s)
[212.158278] Subtest preempt-contexts: SUCCESS (0.280s)
[213.842831] [050/131] (808s left) prime_busy (after)
[213.893429] Starting subtest: after
[213.896964] Starting dynamic subtest: rcs0
[213.932014] Dynamic subtest rcs0: SUCCESS (0.035s)
[213.939593] Starting dynamic subtest: bcs0
[213.971027] Dynamic subtest bcs0: SUCCESS (0.039s)
[213.977968] Starting dynamic subtest: vcs0
[214.011217] Dynamic subtest vcs0: SUCCESS (0.040s)
[214.018735] Starting dynamic subtest: vcs1
[214.052602] Dynamic subtest vcs1: SUCCESS (0.041s)
[214.060842] Starting dynamic subtest: vecs0
[214.094326] Dynamic subtest vecs0: SUCCESS (0.041s)
[214.101314] Starting dynamic subtest: ccs0
[214.133418] Dynamic subtest ccs0: SUCCESS (0.038s)
[214.243406] Subtest after: SUCCESS (0.347s)
[214.310298] [051/131] (807s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[214.407759] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[218.118110] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.709s)
[219.265725] [052/131] (803s left) kms_flip (busy-flip)
[219.359806] Starting subtest: busy-flip
[219.362421] Starting dynamic subtest: A-eDP1
[221.071401] Dynamic subtest A-eDP1: SUCCESS (1.709s)
[221.079042] Starting dynamic subtest: B-eDP1
[222.794205] Dynamic subtest B-eDP1: SUCCESS (1.721s)
[222.803903] Starting dynamic subtest: C-eDP1
[224.512789] Dynamic subtest C-eDP1: SUCCESS (1.716s)
[224.519774] Starting dynamic subtest: D-eDP1
[226.233378] Dynamic subtest D-eDP1: SUCCESS (1.720s)
[226.235692] Subtest busy-flip: SUCCESS (6.874s)
[227.384427] [053/131] (794s left) gen7_exec_parse (chained-batch)
[227.444050] Subtest chained-batch: SKIP (0.000s)
[227.522244] [054/131] (794s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[227.627366] Starting subtest: psr-indfb-scaledprimary
[233.255525] Subtest psr-indfb-scaledprimary: SUCCESS (5.629s)
[233.361270] [055/131] (789s left) kms_big_fb (x-tiled-addfb-size-overflow)
[233.462510] Starting subtest: x-tiled-addfb-size-overflow
[233.463322] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[233.570084] [056/131] (788s left) kms_dsc (dsc-with-formats)
[233.655168] Starting subtest: dsc-with-formats
[233.669955] Subtest dsc-with-formats: SKIP (0.001s)
[233.720998] [057/131] (788s left) gem_exec_suspend (basic-s3-devices)
[233.767318] Starting subtest: basic-S3-devices
[233.768321] Starting dynamic subtest: smem
[244.713187] Dynamic subtest smem: SUCCESS (10.946s)
[244.714752] Subtest basic-S3-devices: SUCCESS (10.948s)
[250.905886] [058/131] (777s left) kms_psr (psr2-dpms)
[251.000450] Starting subtest: psr2-dpms
[251.001742] Starting dynamic subtest: eDP-1
[253.880491] Dynamic subtest eDP-1: SUCCESS (2.879s)
[253.881339] Subtest psr2-dpms: SUCCESS (2.880s)
[254.730140] [059/131] (773s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[254.784598] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[254.785631] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[254.898009] [060/131] (773s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[254.976106] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[254.977004] Starting dynamic subtest: pipe-A-default-mode
[255.266598] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[255.268493] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.289s)
[256.050621] [061/131] (772s left) drm_read (short-buffer-wakeup)
[256.211136] Starting subtest: short-buffer-wakeup
[288.421948] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[288.558377] [062/131] (740s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[288.652259] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[288.653295] Starting dynamic subtest: pipe-A-eDP-1
[288.662644] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[288.670744] Starting dynamic subtest: pipe-B-eDP-1
[288.679749] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[288.687207] Starting dynamic subtest: pipe-C-eDP-1
[288.695814] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[288.702613] Starting dynamic subtest: pipe-D-eDP-1
[288.711486] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[288.713067] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[290.784620] [063/131] (737s left) perf (blocking-parameterized)
[290.889282] Starting subtest: blocking-parameterized
[310.929818] Subtest blocking-parameterized: SUCCESS (20.044s)
[310.978338] [064/131] (717s left) gem_mmap_gtt (fault-concurrent-x)
[311.032237] Subtest fault-concurrent-X: SKIP (0.000s)
[311.094586] [065/131] (717s left) kms_sequence (get-forked)
[311.177952] Starting subtest: get-forked
[311.178933] Starting dynamic subtest: pipe-A-eDP-1
[313.094023] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.916s)
[313.102037] Starting dynamic subtest: pipe-B-eDP-1
[315.604631] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.509s)
[315.611559] Starting dynamic subtest: pipe-C-eDP-1
[318.108143] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.504s)
[318.115769] Starting dynamic subtest: pipe-D-eDP-1
[320.641419] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[320.642292] Subtest get-forked: SUCCESS (9.466s)
[321.476667] [066/131] (707s left) api_intel_bb (add-remove-objects)
[321.524340] Starting subtest: add-remove-objects
[321.531678] Subtest add-remove-objects: SUCCESS (0.008s)
[321.617657] [067/131] (707s left) kms_chamelium_hpd (vga-hpd-fast)
[321.995189] Subtest vga-hpd-fast: SKIP (0.000s)
[322.779611] [068/131] (706s left) syncobj_timeline (wait-for-submit-complex)
[322.839668] Starting subtest: wait-for-submit-complex
[322.902156] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[322.975421] [069/131] (705s left) kms_vblank (wait-idle-hang)
[323.056028] Starting subtest: wait-idle-hang
[323.058462] Starting dynamic subtest: pipe-A-eDP-1
[349.533764] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.484s)
[349.543142] Starting dynamic subtest: pipe-D-eDP-1
[374.492000] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.963s)
[374.493091] Subtest wait-idle-hang: SUCCESS (51.451s)
[375.320088] [070/131] (653s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[375.413727] Starting subtest: y-tiled-32bpp-rotate-180
[375.415687] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[375.503898] [071/131] (653s left) syncobj_timeline (etime-multi-wait-submitted)
[375.549622] Starting subtest: etime-multi-wait-submitted
[375.654587] Subtest etime-multi-wait-submitted: SUCCESS (0.102s)
[375.725120] [072/131] (653s left) gem_exec_flush (basic-wb-ro-default)
[375.779831] Starting subtest: basic-wb-ro-default
[381.231533] Subtest basic-wb-ro-default: SUCCESS (5.453s)
[381.409237] [073/131] (647s left) gem_ctx_engines (none)
[381.472778] Starting subtest: none
[381.475260] Subtest none: SUCCESS (0.001s)
[381.649351] [074/131] (647s left) gem_exec_schedule (fairslice)
[381.703666] Starting subtest: fairslice
[381.704522] Starting dynamic subtest: rcs0
[383.732508] Dynamic subtest rcs0: SUCCESS (2.027s)
[383.741062] Starting dynamic subtest: bcs0
[385.755860] Dynamic subtest bcs0: SUCCESS (2.024s)
[385.763422] Starting dynamic subtest: vcs0
[387.774290] Dynamic subtest vcs0: SUCCESS (2.018s)
[387.785064] Starting dynamic subtest: vcs1
[389.794724] Dynamic subtest vcs1: SUCCESS (2.020s)
[389.803991] Starting dynamic subtest: vecs0
[391.814899] Dynamic subtest vecs0: SUCCESS (2.018s)
[391.823525] Starting dynamic subtest: ccs0
[393.835631] Dynamic subtest ccs0: SUCCESS (2.021s)
[393.836581] Subtest fairslice: SUCCESS (12.134s)
[394.125962] [075/131] (634s left) perf (gen8-unprivileged-single-ctx-counters)
[394.199699] Starting subtest: gen8-unprivileged-single-ctx-counters
[394.201821] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[394.236982] [076/131] (634s left) gem_busy (parallel)
[394.423770] Starting subtest: parallel
[394.424999] Starting dynamic subtest: rcs0
[395.754603] Dynamic subtest rcs0: SUCCESS (1.328s)
[395.767247] Starting dynamic subtest: bcs0
[397.737267] Dynamic subtest bcs0: SUCCESS (1.983s)
[397.748027] Starting dynamic subtest: vcs0
[399.722524] Dynamic subtest vcs0: SUCCESS (1.982s)
[399.732999] Starting dynamic subtest: vcs1
[401.771557] Dynamic subtest vcs1: SUCCESS (2.048s)
[401.782294] Starting dynamic subtest: vecs0
[403.754760] Dynamic subtest vecs0: SUCCESS (1.982s)
[403.765777] Starting dynamic subtest: ccs0
[405.739328] Dynamic subtest ccs0: SUCCESS (1.983s)
[405.740681] Subtest parallel: SUCCESS (11.318s)
[405.977486] [077/131] (623s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[406.087835] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[406.089844] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[406.173433] [078/131] (622s left) syncobj_timeline (device-submit-unordered)
[406.216067] Starting subtest: device-submit-unordered
[406.217094] Subtest device-submit-unordered: SUCCESS (0.000s)
[406.308648] [079/131] (622s left) gem_exec_flush (basic-batch-kernel-default-wb)
[406.370899] Starting subtest: basic-batch-kernel-default-wb
[412.990556] Subtest basic-batch-kernel-default-wb: SUCCESS (6.622s)
[413.174455] [080/131] (616s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[413.269729] Starting subtest: 4-tiled-8bpp-rotate-90
[413.293539] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s)
[413.429680] [081/131] (615s left) i915_pm_freq_mult (media-freq)
[413.470987] Starting subtest: media-freq
[413.472022] Starting dynamic subtest: gt0
[413.473955] Dynamic subtest gt0: SKIP (0.000s)
[413.482285] Starting dynamic subtest: gt1
[413.484013] Dynamic subtest gt1: SKIP (0.000s)
[413.485812] Subtest media-freq: SKIP (0.001s)
[413.575134] [082/131] (615s left) core_setmaster (master-drop-set-shared-fd)
[413.633593] Starting subtest: master-drop-set-shared-fd
[413.643009] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[413.673379] [083/131] (615s left) syncobj_wait (wait-all-for-submit-complex)
[413.727772] Starting subtest: wait-all-for-submit-complex
[413.943490] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[414.012359] [084/131] (615s left) gem_userptr_blits (unsync-unmap)
[414.067693] Subtest unsync-unmap: SKIP (0.000s)
[414.205481] [085/131] (615s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[414.292459] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[414.295584] Starting dynamic subtest: pipe-A-eDP-1
[414.309710] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[414.319050] Starting dynamic subtest: pipe-B-eDP-1
[414.322301] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[414.329281] Starting dynamic subtest: pipe-C-eDP-1
[414.332512] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[414.339343] Starting dynamic subtest: pipe-D-eDP-1
[414.342612] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[414.344281] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[416.445059] [086/131] (612s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[416.526018] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[416.527005] Starting dynamic subtest: pipe-A-eDP-1
[416.535738] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[416.543841] Starting dynamic subtest: pipe-B-eDP-1
[416.552422] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[416.559777] Starting dynamic subtest: pipe-C-eDP-1
[416.567884] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[416.575038] Starting dynamic subtest: pipe-D-eDP-1
[416.583856] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[416.585546] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[418.700588] [087/131] (610s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[423.662875] Starting subtest: pr-cursor-plane-update-sf
[423.665534] Subtest pr-cursor-plane-update-sf: SKIP (0.003s)
[424.494934] [088/131] (604s left) syncobj_timeline (invalid-signal-bad-pad)
[424.548002] Starting subtest: invalid-signal-bad-pad
[424.548951] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[424.640634] [089/131] (604s left) gem_exec_flush (basic-uc-set-default)
[424.693657] Starting subtest: basic-uc-set-default
[430.144443] Subtest basic-uc-set-default: SUCCESS (5.453s)
[430.324197] [090/131] (599s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[430.438349] Starting subtest: fbc-pr-sprite-mmap-gtt
[430.440089] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[430.503774] [091/131] (599s left) kms_cursor_crc (cursor-onscreen-32x10)
[430.668485] Starting subtest: cursor-onscreen-32x10
[430.705506] Subtest cursor-onscreen-32x10: SKIP (0.035s)
[430.977585] [092/131] (598s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[431.067061] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[431.067972] Starting dynamic subtest: pipe-A-eDP-1
[432.380298] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.313s)
[432.389043] Starting dynamic subtest: pipe-B-eDP-1
[434.765937] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.385s)
[434.775276] Starting dynamic subtest: pipe-C-eDP-1
[437.101175] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.334s)
[437.109009] Starting dynamic subtest: pipe-D-eDP-1
[439.427116] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.326s)
[439.428573] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.363s)
[440.593063] [093/131] (589s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[440.693300] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[440.705389] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[440.825625] [094/131] (588s left) gem_exec_whisper (basic-fds-forked)
[440.881631] Starting subtest: basic-fds-forked
[464.144654] Subtest basic-fds-forked: SUCCESS (23.269s)
[464.326085] [095/131] (565s left) i915_query (query-regions-sanity-check)
[464.381429] Starting subtest: query-regions-sanity-check
[464.398731] Subtest query-regions-sanity-check: SUCCESS (0.019s)
[464.525058] [096/131] (565s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[464.621334] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[471.458779] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.841s)
[471.576059] [097/131] (558s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[471.665283] Starting subtest: primary-yf-tiled-reflect-x-90
[471.667272] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[471.732588] [098/131] (558s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[471.782264] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[471.783299] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[471.882485] [099/131] (557s left) gem_ctx_shared (single-timeline)
[471.947924] Starting subtest: single-timeline
[471.963496] Subtest single-timeline: SUCCESS (0.014s)
[472.189257] [100/131] (557s left) prime_mmap (test_forked_cpu_write)
[472.238378] Starting subtest: test_forked_cpu_write
[472.239321] Starting dynamic subtest: test_forked_cpu_write-smem
[472.247711] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[472.252964] Subtest test_forked_cpu_write: SUCCESS (0.011s)
[472.361159] [101/131] (557s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[472.451018] Starting subtest: plane-scaler-unity-scaling-with-rotation
[472.452072] Starting dynamic subtest: pipe-A
[472.788752] Dynamic subtest pipe-A: SUCCESS (0.337s)
[472.797294] Starting dynamic subtest: pipe-B
[474.158136] Dynamic subtest pipe-B: SUCCESS (1.369s)
[474.166690] Starting dynamic subtest: pipe-C
[475.585029] Dynamic subtest pipe-C: SUCCESS (1.427s)
[475.593637] Starting dynamic subtest: pipe-D
[477.003859] Dynamic subtest pipe-D: SUCCESS (1.419s)
[477.004947] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.555s)
[478.169017] [102/131] (551s left) kms_pm_rpm (i2c)
[479.901327] Starting subtest: i2c
[485.346345] Subtest i2c: SUCCESS (5.448s)
[485.439409] [103/131] (544s left) gem_mmap_gtt (big-copy-odd)
[485.484604] Subtest big-copy-odd: SKIP (0.000s)
[485.541641] [104/131] (544s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[485.658114] Starting subtest: short-flip-after-cursor-atomic-transitions
[486.622857] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.964s)
[487.445468] [105/131] (542s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[487.500043] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[487.502045] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[487.681344] [106/131] (542s left) gem_ctx_persistence (engines-cleanup)
[487.735241] Starting subtest: engines-cleanup
[487.736459] Starting dynamic subtest: rcs0
[487.834038] Dynamic subtest rcs0: SUCCESS (0.098s)
[487.844699] Starting dynamic subtest: bcs0
[487.878572] Dynamic subtest bcs0: SUCCESS (0.043s)
[487.889551] Starting dynamic subtest: vcs0
[487.941987] Dynamic subtest vcs0: SUCCESS (0.061s)
[487.952948] Starting dynamic subtest: vcs1
[487.996622] Dynamic subtest vcs1: SUCCESS (0.053s)
[488.007182] Starting dynamic subtest: vecs0
[488.028442] Dynamic subtest vecs0: SUCCESS (0.030s)
[488.037615] Starting dynamic subtest: ccs0
[488.135453] Dynamic subtest ccs0: SUCCESS (0.105s)
[488.136735] Subtest engines-cleanup: SUCCESS (0.401s)
[488.215420] [107/131] (541s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[488.320207] Starting subtest: yf-tiled-64bpp-rotate-90
[488.321934] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[488.435141] [108/131] (541s left) kms_cursor_crc (cursor-sliding-512x170)
[488.710317] Starting subtest: cursor-sliding-512x170
[488.711987] Subtest cursor-sliding-512x170: SKIP (0.001s)
[488.870207] [109/131] (541s left) gem_exec_balancer (parallel-balancer)
[489.122706] Starting subtest: parallel-balancer
[490.001815] Subtest parallel-balancer: SUCCESS (0.878s)
[490.100549] [110/131] (540s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[495.097977] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[495.100216] Starting dynamic subtest: pipe-A-eDP-1
[495.887126] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[495.895779] Starting dynamic subtest: pipe-B-eDP-1
[497.013433] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[497.015251] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.916s)
[498.183515] [111/131] (532s left) prime_mmap (test_correct)
[498.231529] Starting subtest: test_correct
[498.232531] Starting dynamic subtest: test_correct-smem
[498.264083] Dynamic subtest test_correct-smem: SUCCESS (0.034s)
[498.265239] Subtest test_correct: SUCCESS (0.034s)
[498.385791] [112/131] (531s left) kms_flip (nonexisting-fb-interruptible)
[498.477243] Starting subtest: nonexisting-fb-interruptible
[498.480686] Starting dynamic subtest: A-eDP1
[499.678412] Dynamic subtest A-eDP1: SUCCESS (1.199s)
[499.687136] Starting dynamic subtest: B-eDP1
[500.795459] Dynamic subtest B-eDP1: SUCCESS (1.117s)
[500.804652] Starting dynamic subtest: C-eDP1
[501.918972] Dynamic subtest C-eDP1: SUCCESS (1.123s)
[501.929173] Starting dynamic subtest: D-eDP1
[503.044607] Dynamic subtest D-eDP1: SUCCESS (1.124s)
[503.047485] Subtest nonexisting-fb-interruptible: SUCCESS (4.571s)
[504.207114] [113/131] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[504.307371] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[504.309100] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[504.423625] [114/131] (525s left) gem_eio (hibernate)
[504.645492] Starting subtest: hibernate
[519.211299] Subtest hibernate: SUCCESS (14.570s)
[526.337829] [115/131] (511s left) gem_pwrite (basic-exhaustion)
[526.397602] Subtest basic-exhaustion: SKIP (0.000s)
[526.459605] [116/131] (510s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[526.551653] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[526.553455] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[526.662320] [117/131] (510s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[526.758794] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[527.132157] Starting dynamic subtest: pipe-A-eDP-1
[529.898982] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.765s)
[530.268083] Starting dynamic subtest: pipe-B-eDP-1
[533.022206] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.762s)
[533.383195] Starting dynamic subtest: pipe-C-eDP-1
[536.146659] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s)
[536.502842] Starting dynamic subtest: pipe-D-eDP-1
[539.272114] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[539.273293] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.517s)
[540.442015] [118/131] (496s left) gem_exec_store (pages)
[540.506962] Starting subtest: pages
[540.507937] Starting dynamic subtest: rcs0
[540.635889] Dynamic subtest rcs0: SUCCESS (0.128s)
[540.647433] Starting dynamic subtest: bcs0
[540.719307] Dynamic subtest bcs0: SUCCESS (0.082s)
[540.728713] Starting dynamic subtest: vcs0
[540.796045] Dynamic subtest vcs0: SUCCESS (0.076s)
[540.805289] Starting dynamic subtest: vcs1
[540.866970] Dynamic subtest vcs1: SUCCESS (0.070s)
[540.876292] Starting dynamic subtest: vecs0
[540.941833] Dynamic subtest vecs0: SUCCESS (0.074s)
[540.952110] Starting dynamic subtest: ccs0
[541.015315] Dynamic subtest ccs0: SUCCESS (0.073s)
[541.016218] Subtest pages: SUCCESS (0.509s)
[541.190388] [119/131] (496s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[541.560095] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[542.347074] [120/131] (495s left) kms_scaling_modes (scaling-mode-full)
[542.434978] Starting subtest: scaling-mode-full
[542.435903] Starting dynamic subtest: pipe-A-eDP-1
[542.552087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.116s)
[542.562663] Starting dynamic subtest: pipe-B-eDP-1
[543.688488] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.136s)
[543.699803] Starting dynamic subtest: pipe-C-eDP-1
[544.891058] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.202s)
[544.900998] Starting dynamic subtest: pipe-D-eDP-1
[546.016215] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[546.017175] Subtest scaling-mode-full: SUCCESS (3.583s)
[547.255876] [121/131] (490s left) gem_mmap (bad-size)
[547.306827] Subtest bad-size: SKIP (0.000s)
[547.360720] [122/131] (490s left) kms_cursor_crc (async-cursor-crc-framebuffer-change)
[547.464626] Starting subtest: async-cursor-crc-framebuffer-change
[547.465471] Starting dynamic subtest: pipe-A-eDP-1
[548.028485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[548.037942] Starting dynamic subtest: pipe-D-eDP-1
[549.271554] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[549.272729] Subtest async-cursor-crc-framebuffer-change: SUCCESS (1.806s)
[550.093631] [123/131] (487s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[550.194675] Starting subtest: fbc-tiling-linear
[553.982684] Subtest fbc-tiling-linear: SUCCESS (3.791s)
[555.083518] [124/131] (482s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[555.180489] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[555.182309] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[555.276086] [125/131] (482s left) perf_pmu (render-node-busy)
[555.345046] Starting subtest: render-node-busy
[555.346212] Starting dynamic subtest: rcs0
[555.946521] Dynamic subtest rcs0: SUCCESS (0.601s)
[555.958742] Starting dynamic subtest: bcs0
[556.518848] Dynamic subtest bcs0: SUCCESS (0.571s)
[556.533666] Starting dynamic subtest: vcs0
[557.736312] Dynamic subtest vcs0: SUCCESS (1.216s)
[557.748985] Starting dynamic subtest: vcs1
[559.723085] Dynamic subtest vcs1: SUCCESS (1.983s)
[559.733035] Starting dynamic subtest: vecs0
[561.704626] Dynamic subtest vecs0: SUCCESS (1.982s)
[561.717286] Starting dynamic subtest: ccs0
[562.284269] Dynamic subtest ccs0: SUCCESS (0.579s)
[562.285587] Subtest render-node-busy: SUCCESS (6.942s)
[562.359302] [126/131] (475s left) kms_plane_multiple (tiling-yf)
[562.453020] Starting subtest: tiling-yf
[562.454905] Subtest tiling-yf: SKIP (0.000s)
[562.522079] [127/131] (475s left) gem_gtt_cpu_tlb
[562.641788] [128/131] (475s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[562.730797] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[569.049152] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.322s)
[569.147561] [129/131] (468s left) kms_psr (pr-cursor-plane-move)
[569.245727] Starting subtest: pr-cursor-plane-move
[569.247652] Subtest pr-cursor-plane-move: SKIP (0.000s)
[569.312465] [130/131] (468s left) gem_softpin (softpin)
[569.366750] Starting subtest: softpin
[601.815249] Subtest softpin: SUCCESS (32.456s)
[601.959791] [131/131] (435s left) kms_cursor_edge_walk (256x256-top-edge)
[602.053022] Starting subtest: 256x256-top-edge
[602.054022] Starting dynamic subtest: pipe-A-eDP-1
[605.506426] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[605.521469] Starting dynamic subtest: pipe-D-eDP-1
[608.614509] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.108s)
[608.615672] Subtest 256x256-top-edge: SUCCESS (6.563s)
[609.422605] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_chamelium_edid
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_joiner
results: parsing output: 8/ for test: gem_ctx_exec
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: gem_pread
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_properties
results: parsing output: 14/ for test: gem_mmap
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: gem_fenced_exec_thrash
results: parsing output: 17/ for test: gem_ctx_param
results: parsing output: 18/ for test: kms_plane_cursor
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_spin_batch
results: parsing output: 24/ for test: i915_suspend
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: prime_mmap
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: gem_unfence_active_buffers
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: prime_mmap
results: parsing output: 32/ for test: kms_lease
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: gem_ctx_sseu
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_draw_crc
results: parsing output: 43/ for test: kms_setmode
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: syncobj_basic
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: prime_busy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: gen7_exec_parse
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_dsc
results: parsing output: 56/ for test: gem_exec_suspend
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: drm_read
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: kms_sequence
results: parsing output: 65/ for test: api_intel_bb
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_vblank
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: gem_ctx_engines
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: gem_busy
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: gem_exec_flush
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: i915_pm_freq_mult
results: parsing output: 81/ for test: core_setmaster
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_exec_flush
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: gem_exec_whisper
results: parsing output: 94/ for test: i915_query
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: gem_ctx_shared
results: parsing output: 99/ for test: prime_mmap
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: kms_pm_rpm
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: gem_ctx_persistence
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: prime_mmap
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: gem_pwrite
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: gem_exec_store
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: kms_scaling_modes
results: parsing output: 120/ for test: gem_mmap
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_plane_multiple
results: parsing output: 126/ for test: gem_gtt_cpu_tlb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_softpin
results: parsing output: 130/ for test: kms_cursor_edge_walk
Done.