[58.337961] Initializing watchdogs
[58.338015]   /dev/watchdog0
[58.363859] [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.368366] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.371067] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.374197] [001/133] (960s left) perf_pmu (busy)
[58.435015] Starting subtest: busy
[58.437346] Starting dynamic subtest: rcs0
[59.038732] Dynamic subtest rcs0: SUCCESS (0.608s)
[59.048452] Starting dynamic subtest: bcs0
[59.606626] Dynamic subtest bcs0: SUCCESS (0.571s)
[59.616200] Starting dynamic subtest: vcs0
[60.885973] Dynamic subtest vcs0: SUCCESS (1.286s)
[60.895911] Starting dynamic subtest: vcs1
[62.934038] Dynamic subtest vcs1: SUCCESS (2.059s)
[62.942049] Starting dynamic subtest: vecs0
[64.917434] Dynamic subtest vecs0: SUCCESS (1.991s)
[64.925487] Starting dynamic subtest: ccs0
[65.484513] Dynamic subtest ccs0: SUCCESS (0.569s)
[65.487189] Subtest busy: SUCCESS (7.092s)
[65.596359] [002/133] (953s left) gem_unfence_active_buffers
[65.734099] [003/133] (953s left) syncobj_timeline (reset-multiple-signaled)
[65.782966] Starting subtest: reset-multiple-signaled
[65.785322] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[65.891373] [004/133] (953s left) gem_fence_thrash (bo-write-verify-none)
[65.924163] Starting subtest: bo-write-verify-none
[65.940148] Subtest bo-write-verify-none: SKIP (0.011s)
[65.990553] [005/133] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[66.088017] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[72.980852] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.911s)
[73.137917] [006/133] (945s left) gem_ctx_persistence (heartbeat-close)
[73.190189] Starting subtest: heartbeat-close
[73.194942] Subtest heartbeat-close: SKIP (0.000s)
[73.301723] [007/133] (945s left) gem_ctx_param (root-set)
[73.355542] Starting subtest: root-set
[73.358057] Subtest root-set: SUCCESS (0.001s)
[73.460894] [008/133] (945s left) kms_getfb (getfb-handle-not-fb)
[73.559329] Starting subtest: getfb-handle-not-fb
[73.561337] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[73.675763] [009/133] (945s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[73.781375] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[73.785611] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[73.874806] [010/133] (945s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[74.121107] Starting subtest: cursor-rapid-movement-256x256
[74.125251] Starting dynamic subtest: pipe-A-eDP-1
[74.686397] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s)
[74.714606] Starting dynamic subtest: pipe-D-eDP-1
[75.863620] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.156s)
[75.865958] Subtest cursor-rapid-movement-256x256: SUCCESS (1.744s)
[76.714417] [011/133] (942s left) gem_ctx_engines (execute-one)
[76.774589] Starting subtest: execute-one
[78.984957] Subtest execute-one: SUCCESS (2.212s)
[79.164620] [012/133] (940s left) kms_color (ctm-green-to-red)
[79.258448] Starting subtest: ctm-green-to-red
[79.260884] Starting dynamic subtest: pipe-A-eDP-1
[79.968504] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[79.977642] Starting dynamic subtest: pipe-B-eDP-1
[81.431794] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.462s)
[81.440621] Starting dynamic subtest: pipe-C-eDP-1
[82.810695] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[82.819065] Starting dynamic subtest: pipe-D-eDP-1
[84.103801] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.294s)
[84.106267] Subtest ctm-green-to-red: SUCCESS (4.844s)
[84.951191] [013/133] (934s left) kms_invalid_mode (clock-too-high)
[85.060548] Starting subtest: clock-too-high
[85.062559] Starting dynamic subtest: pipe-A-eDP-1
[85.066771] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[85.076423] Starting dynamic subtest: pipe-B-eDP-1
[85.080821] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[85.088272] Starting dynamic subtest: pipe-C-eDP-1
[85.092241] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[85.100317] Starting dynamic subtest: pipe-D-eDP-1
[85.104461] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[85.108558] Subtest clock-too-high: SKIP (0.003s)
[85.141570] [014/133] (934s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[87.060852] Starting subtest: dpms-mode-unset-non-lpsp
[88.216536] Subtest dpms-mode-unset-non-lpsp: SKIP (1.154s)
[88.578672] [015/133] (930s left) kms_psr (psr-sprite-plane-onoff)
[88.689998] Starting subtest: psr-sprite-plane-onoff
[88.692388] Starting dynamic subtest: eDP-1
[90.413845] Dynamic subtest eDP-1: SUCCESS (1.724s)
[90.416132] Subtest psr-sprite-plane-onoff: SUCCESS (1.724s)
[91.228213] [016/133] (928s left) gem_spin_batch (resubmit)
[91.276826] Starting subtest: resubmit
[91.279125] Starting dynamic subtest: rcs0
[91.283895] Dynamic subtest rcs0: SUCCESS (0.007s)
[91.293649] Starting dynamic subtest: bcs0
[91.295796] Dynamic subtest bcs0: SUCCESS (0.002s)
[91.303168] Starting dynamic subtest: vcs0
[91.305321] Dynamic subtest vcs0: SUCCESS (0.002s)
[91.313515] Starting dynamic subtest: vcs1
[91.315654] Dynamic subtest vcs1: SUCCESS (0.003s)
[91.323160] Starting dynamic subtest: vecs0
[91.325279] Dynamic subtest vecs0: SUCCESS (0.003s)
[91.332318] Starting dynamic subtest: ccs0
[91.334565] Dynamic subtest ccs0: SUCCESS (0.003s)
[91.336680] Subtest resubmit: SUCCESS (0.021s)
[91.524607] [017/133] (927s left) gen9_exec_parse (batch-without-end)
[91.588672] Subtest batch-without-end: SKIP (0.000s)
[91.653641] [018/133] (927s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[91.712966] Starting subtest: single-wait-all-for-submit-unsubmitted
[91.818923] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[91.904106] [019/133] (927s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[92.005646] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[92.008079] Starting dynamic subtest: pipe-A-eDP-1
[97.886536] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.884s)
[97.896633] Starting dynamic subtest: pipe-B-eDP-1
[104.543457] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.655s)
[104.545821] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.542s)
[105.407133] [020/133] (914s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[105.504377] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[105.881799] Starting dynamic subtest: pipe-A-eDP-1
[108.731527] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.795s)
[109.041088] Starting dynamic subtest: pipe-B-eDP-1
[111.850255] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.763s)
[112.159111] Starting dynamic subtest: pipe-C-eDP-1
[114.973183] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[115.280217] Starting dynamic subtest: pipe-D-eDP-1
[118.097934] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[118.100518] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.543s)
[119.240541] [021/133] (900s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[119.342044] Starting subtest: fbc-pr-sprite-mmap-cpu
[119.346056] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[119.410119] [022/133] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[119.510368] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[126.907748] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.400s)
[127.033333] [023/133] (892s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[127.134173] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[127.138121] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[127.232417] [024/133] (892s left) tools_test (tools_test)
[127.288095] Starting subtest: tools_test
[127.334795] Subtest tools_test: SUCCESS (0.064s)
[127.396433] [025/133] (892s left) gem_exec_schedule (pi-ringfull)
[127.577638] Starting subtest: pi-ringfull
[127.579872] Starting dynamic subtest: rcs0
[127.645481] Dynamic subtest rcs0: SUCCESS (0.071s)
[127.659529] Starting dynamic subtest: bcs0
[127.672706] Dynamic subtest bcs0: SUCCESS (0.027s)
[127.685534] Starting dynamic subtest: vcs0
[127.698617] Dynamic subtest vcs0: SUCCESS (0.025s)
[127.709594] Starting dynamic subtest: vcs1
[127.725652] Dynamic subtest vcs1: SUCCESS (0.026s)
[127.737123] Starting dynamic subtest: vecs0
[127.752670] Dynamic subtest vecs0: SUCCESS (0.026s)
[127.763528] Starting dynamic subtest: ccs0
[127.779962] Dynamic subtest ccs0: SUCCESS (0.027s)
[127.782313] Subtest pi-ringfull: SUCCESS (0.206s)
[128.021392] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[128.024802] [026/133] (891s left) kms_async_flips (test-cursor-atomic)
[128.115810] Starting subtest: test-cursor-atomic
[128.488776] Starting dynamic subtest: pipe-A-eDP-1
[129.239647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.751s)
[129.618713] Starting dynamic subtest: pipe-B-eDP-1
[130.366208] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.754s)
[130.748879] Starting dynamic subtest: pipe-C-eDP-1
[131.493303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.751s)
[131.854970] Starting dynamic subtest: pipe-D-eDP-1
[132.631832] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.783s)
[132.634176] Subtest test-cursor-atomic: SUCCESS (4.518s)
[133.810277] [027/133] (886s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[133.926229] Starting subtest: cursorA-vs-flipB-varying-size
[133.930607] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[134.073482] [028/133] (885s left) i915_drm_fdinfo (busy-idle)
[134.111186] Starting subtest: busy-idle
[134.113518] Starting dynamic subtest: rcs0
[134.132321] Dynamic subtest rcs0: SKIP (0.021s)
[134.141729] Starting dynamic subtest: bcs0
[134.149743] Dynamic subtest bcs0: SKIP (0.017s)
[134.157150] Starting dynamic subtest: vcs0
[134.161437] Dynamic subtest vcs0: SKIP (0.000s)
[134.168932] Starting dynamic subtest: vcs1
[134.173318] Dynamic subtest vcs1: SKIP (0.000s)
[134.180633] Starting dynamic subtest: vecs0
[134.184731] Dynamic subtest vecs0: SKIP (0.000s)
[134.191806] Starting dynamic subtest: ccs0
[134.195994] Dynamic subtest ccs0: SKIP (0.000s)
[134.200111] Subtest busy-idle: SKIP (0.042s)
[134.234281] [029/133] (885s left) gem_exec_parallel (engines)
[134.295316] Starting subtest: engines
[134.297692] Starting dynamic subtest: basic
[135.893347] Dynamic subtest basic: SUCCESS (1.596s)
[135.902887] Starting dynamic subtest: contexts
[140.165038] Dynamic subtest contexts: SUCCESS (4.269s)
[140.174144] Starting dynamic subtest: fds
[144.040354] Dynamic subtest fds: SUCCESS (3.873s)
[144.053307] Starting dynamic subtest: userptr
[145.877855] Dynamic subtest userptr: SUCCESS (1.834s)
[145.880969] Subtest engines: SUCCESS (11.581s)
[146.068152] [030/133] (873s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[146.170716] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[146.172882] Starting dynamic subtest: pipe-A
[146.190803] Dynamic subtest pipe-A: SKIP (0.017s)
[146.199334] Starting dynamic subtest: pipe-B
[146.224127] Dynamic subtest pipe-B: SKIP (0.031s)
[146.232693] Starting dynamic subtest: pipe-C
[146.255828] Dynamic subtest pipe-C: SKIP (0.031s)
[146.265053] Starting dynamic subtest: pipe-D
[146.297932] Dynamic subtest pipe-D: SKIP (0.041s)
[146.302262] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.123s)
[146.405575] [031/133] (873s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[146.449462] Starting subtest: wait-all-for-submit-delayed-submit
[146.550838] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[146.628992] [032/133] (873s left) perf (invalid-create-userspace-config)
[146.740534] Starting subtest: invalid-create-userspace-config
[146.742721] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[146.781186] [033/133] (873s left) gem_exec_fence (keep-in-fence)
[146.949081] Starting subtest: keep-in-fence
[146.951289] Starting dynamic subtest: rcs0
[147.007075] Dynamic subtest rcs0: SUCCESS (0.061s)
[147.015957] Starting dynamic subtest: bcs0
[147.061520] Dynamic subtest bcs0: SUCCESS (0.052s)
[147.070557] Starting dynamic subtest: vcs0
[148.886435] Dynamic subtest vcs0: SUCCESS (1.822s)
[148.897609] Starting dynamic subtest: vcs1
[150.986887] Dynamic subtest vcs1: SUCCESS (2.045s)
[150.997834] Starting dynamic subtest: vecs0
[152.918561] Dynamic subtest vecs0: SUCCESS (1.982s)
[152.929573] Starting dynamic subtest: ccs0
[153.158803] Dynamic subtest ccs0: SUCCESS (0.239s)
[153.161785] Subtest keep-in-fence: SUCCESS (6.213s)
[154.980467] [034/133] (865s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[155.074407] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[162.342149] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.269s)
[162.454283] [035/133] (857s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[162.505849] Starting subtest: etime-single-wait-available-unsubmitted
[162.610040] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.103s)
[162.687440] [036/133] (857s left) kms_dsc (dsc-with-output-formats-with-bpc)
[162.779146] Starting subtest: dsc-with-output-formats-with-bpc
[162.835976] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[162.872673] [037/133] (857s left) gem_exec_reloc (basic-range)
[162.940787] Subtest basic-range: SKIP (0.000s)
[163.002406] [038/133] (857s left) gem_lmem_swapping (heavy-verify-multi)
[163.043114] Subtest heavy-verify-multi: SKIP (0.000s)
[163.081826] [039/133] (857s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[163.184615] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[164.285642] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.101s)
[164.395931] [040/133] (855s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[164.494278] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[172.044944] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.553s)
[172.178483] [041/133] (848s left) gem_flink_basic (basic)
[172.231695] Starting subtest: basic
[172.234170] Subtest basic: SUCCESS (0.000s)
[172.330383] [042/133] (848s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[172.426114] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[172.428246] Starting dynamic subtest: pipe-A
[172.762284] Dynamic subtest pipe-A: SUCCESS (0.338s)
[172.770595] Starting dynamic subtest: pipe-B
[174.172508] Dynamic subtest pipe-B: SUCCESS (1.409s)
[174.181983] Starting dynamic subtest: pipe-C
[175.603179] Dynamic subtest pipe-C: SUCCESS (1.430s)
[175.612040] Starting dynamic subtest: pipe-D
[177.030252] Dynamic subtest pipe-D: SUCCESS (1.426s)
[177.032557] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.607s)
[178.199786] [043/133] (842s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[178.300834] Starting subtest: y-tiled-64bpp-rotate-180
[178.305385] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[178.409047] [044/133] (842s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[178.466306] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[178.470620] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[178.662303] [045/133] (841s left) gem_exec_params (invalid-ring2)
[178.726869] Starting subtest: invalid-ring2
[178.728798] Subtest invalid-ring2: SUCCESS (0.000s)
[178.826345] [046/133] (841s left) gem_exec_fence (basic-busy)
[179.000287] Starting subtest: basic-busy
[179.003059] Starting dynamic subtest: rcs0
[179.079659] Dynamic subtest rcs0: SUCCESS (0.079s)
[179.089731] Starting dynamic subtest: bcs0
[179.147343] Dynamic subtest bcs0: SUCCESS (0.066s)
[179.157250] Starting dynamic subtest: vcs0
[179.209146] Dynamic subtest vcs0: SUCCESS (0.060s)
[179.220050] Starting dynamic subtest: vcs1
[179.273061] Dynamic subtest vcs1: SUCCESS (0.062s)
[179.282276] Starting dynamic subtest: vecs0
[179.328818] Dynamic subtest vecs0: SUCCESS (0.054s)
[179.338253] Starting dynamic subtest: ccs0
[179.386501] Dynamic subtest ccs0: SUCCESS (0.056s)
[179.388857] Subtest basic-busy: SUCCESS (0.388s)
[180.981677] [047/133] (839s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[181.083904] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[181.086216] Starting dynamic subtest: pipe-A-eDP-1
[181.106680] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[181.116465] Starting dynamic subtest: pipe-B-eDP-1
[181.135727] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[181.143458] Starting dynamic subtest: pipe-C-eDP-1
[181.162589] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[181.170384] Starting dynamic subtest: pipe-D-eDP-1
[181.189670] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[181.191825] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[183.362645] [048/133] (837s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[183.428729] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[183.493383] [049/133] (837s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[183.578564] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[183.582931] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[183.678339] [050/133] (837s left) kms_vblank (query-forked-hang)
[183.766055] Starting subtest: query-forked-hang
[183.768243] Starting dynamic subtest: pipe-A-eDP-1
[211.683976] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.916s)
[211.698380] Starting dynamic subtest: pipe-D-eDP-1
[226.658136] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.970s)
[226.660311] Subtest query-forked-hang: SUCCESS (42.891s)
[227.471165] [051/133] (793s left) gem_exec_reloc (basic-write-wc)
[227.540227] Subtest basic-write-wc: SKIP (0.000s)
[227.619127] [052/133] (793s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[227.723818] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[227.727961] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[227.808838] [053/133] (793s left) kms_flip (basic-plain-flip)
[227.914644] Starting subtest: basic-plain-flip
[227.916576] Starting dynamic subtest: A-eDP1
[229.564505] Dynamic subtest A-eDP1: SUCCESS (1.651s)
[229.576362] Starting dynamic subtest: B-eDP1
[231.199635] Dynamic subtest B-eDP1: SUCCESS (1.633s)
[231.213369] Starting dynamic subtest: C-eDP1
[232.827557] Dynamic subtest C-eDP1: SUCCESS (1.625s)
[232.838495] Starting dynamic subtest: D-eDP1
[234.472767] Dynamic subtest D-eDP1: SUCCESS (1.642s)
[234.478575] Subtest basic-plain-flip: SUCCESS (6.567s)
[235.647962] [054/133] (785s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[235.751175] Starting subtest: flip-vs-dpms-off-vs-modeset
[235.753387] Starting dynamic subtest: A-eDP1
[239.366244] Dynamic subtest A-eDP1: SUCCESS (3.612s)
[239.375427] Starting dynamic subtest: B-eDP1
[242.573386] Dynamic subtest B-eDP1: SUCCESS (3.206s)
[242.582647] Starting dynamic subtest: C-eDP1
[245.673820] Dynamic subtest C-eDP1: SUCCESS (3.100s)
[245.684917] Starting dynamic subtest: D-eDP1
[248.770580] Dynamic subtest D-eDP1: SUCCESS (3.094s)
[248.772705] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.022s)
[249.575197] [055/133] (771s left) gem_exec_params (cliprects-invalid)
[249.644803] Starting subtest: cliprects-invalid
[249.646736] Subtest cliprects-invalid: SUCCESS (0.000s)
[249.750499] [056/133] (771s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[249.851034] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[249.855521] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[249.947748] [057/133] (771s left) kms_lease (lease-invalid-connector)
[250.034183] Starting subtest: lease-invalid-connector
[250.036490] Starting dynamic subtest: pipe-A-eDP-1
[250.038859] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[250.047595] Starting dynamic subtest: pipe-B-eDP-1
[250.049732] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[250.058534] Starting dynamic subtest: pipe-C-eDP-1
[250.060702] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[250.068078] Starting dynamic subtest: pipe-D-eDP-1
[250.070590] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[250.072610] Subtest lease-invalid-connector: SUCCESS (0.004s)
[250.108039] [058/133] (770s left) gem_ctx_shared (single-timeline)
[250.162637] Starting subtest: single-timeline
[250.182679] Subtest single-timeline: SUCCESS (0.014s)
[250.410907] [059/133] (770s left) gem_exec_params (rel-constants-invalid-ring)
[250.459660] Starting subtest: rel-constants-invalid-ring
[250.462079] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[250.554534] [060/133] (770s left) gem_exec_balancer (parallel-bb-first)
[250.806608] Starting subtest: parallel-bb-first
[251.727182] Subtest parallel-bb-first: SUCCESS (0.920s)
[252.939406] [061/133] (768s left) gem_pxp (reject-modify-context-protection-off-3)
[253.066304] Starting subtest: reject-modify-context-protection-off-3
[253.068915] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[253.171364] [062/133] (768s left) gem_userptr_blits (readonly-unsync)
[253.241678] Subtest readonly-unsync: SKIP (0.000s)
[253.371529] [063/133] (767s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[253.471390] Starting subtest: x-tiled-64bpp-rotate-90
[253.491409] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[253.608062] [064/133] (767s left) i915_hangman (engine-error-state-capture)
[253.669557] Starting subtest: engine-error-state-capture
[253.671638] Starting dynamic subtest: rcs0
[256.884140] Dynamic subtest rcs0: SUCCESS (3.213s)
[256.895072] Starting dynamic subtest: bcs0
[262.901462] Dynamic subtest bcs0: SUCCESS (6.014s)
[262.912676] Starting dynamic subtest: vcs0
[268.852048] Dynamic subtest vcs0: SUCCESS (5.947s)
[268.862755] Starting dynamic subtest: vcs1
[274.804847] Dynamic subtest vcs1: SUCCESS (5.949s)
[274.816346] Starting dynamic subtest: vecs0
[279.796321] Dynamic subtest vecs0: SUCCESS (4.988s)
[279.807566] Starting dynamic subtest: ccs0
[284.853186] Dynamic subtest ccs0: SUCCESS (5.053s)
[284.856203] Subtest engine-error-state-capture: SUCCESS (31.183s)
[284.934544] [065/133] (736s left) api_intel_allocator (fork-simple-once)
[284.995279] Starting subtest: fork-simple-once
[285.013274] Subtest fork-simple-once: SUCCESS (0.021s)
[285.152466] [066/133] (736s left) kms_hdr (brightness-with-hdr)
[285.240891] Starting subtest: brightness-with-hdr
[285.246881] Subtest brightness-with-hdr: SKIP (0.000s)
[285.313744] [067/133] (736s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[285.406426] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[285.410637] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[285.494279] [068/133] (735s left) syncobj_wait (reset-signaled)
[285.547935] Starting subtest: reset-signaled
[285.549769] Subtest reset-signaled: SUCCESS (0.000s)
[285.652951] [069/133] (735s left) kms_psr (psr2-basic)
[285.730295] Starting subtest: psr2-basic
[285.732504] Starting dynamic subtest: eDP-1
[287.344390] Dynamic subtest eDP-1: SUCCESS (1.613s)
[287.346602] Subtest psr2-basic: SUCCESS (1.614s)
[288.145488] [070/133] (733s left) kms_cursor_crc (cursor-suspend)
[288.275623] Starting subtest: cursor-suspend
[288.277938] Starting dynamic subtest: pipe-A-eDP-1
[321.559446] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.282s)
[321.568345] Starting dynamic subtest: pipe-D-eDP-1
[355.526322] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.791s)
[355.529062] Subtest cursor-suspend: SUCCESS (7.076s)
[356.357254] [071/133] (665s left) device_reset (cold-reset-bound)
[356.421877] Starting subtest: cold-reset-bound
[356.428480] Subtest cold-reset-bound: SKIP (0.000s)
[356.500902] [072/133] (665s left) gem_busy (semaphore)
[356.686428] Subtest semaphore: SKIP (0.000s)
[356.910948] [073/133] (664s left) kms_panel_fitting (legacy)
[357.006372] Starting subtest: legacy
[357.008831] Starting dynamic subtest: pipe-A-eDP-1
[357.532446] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[357.558462] Starting dynamic subtest: pipe-B-eDP-1
[359.131308] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.622s)
[359.159438] Starting dynamic subtest: pipe-C-eDP-1
[360.678994] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.560s)
[360.704926] Starting dynamic subtest: pipe-D-eDP-1
[362.216411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.545s)
[362.219201] Subtest legacy: SUCCESS (5.333s)
[363.415557] [074/133] (658s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[363.515162] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[363.517893] Starting dynamic subtest: pipe-A-eDP-1
[363.608374] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[363.619795] Starting dynamic subtest: pipe-B-eDP-1
[364.772168] Dynamic subtest pipe-B-eDP-1: SKIP (1.175s)
[364.777347] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.277s)
[365.966573] [075/133] (655s left) kms_plane_cursor (viewport)
[366.060232] Starting subtest: viewport
[366.065353] Starting dynamic subtest: pipe-A-eDP-1-size-64
[368.627099] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.588s)
[368.688060] Starting dynamic subtest: pipe-A-eDP-1-size-128
[371.256264] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.592s)
[371.316868] Starting dynamic subtest: pipe-A-eDP-1-size-256
[373.890115] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.593s)
[374.244737] Starting dynamic subtest: pipe-B-eDP-1-size-64
[377.410159] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.185s)
[377.470452] Starting dynamic subtest: pipe-B-eDP-1-size-128
[379.983173] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.527s)
[380.044110] Starting dynamic subtest: pipe-B-eDP-1-size-256
[382.536455] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.503s)
[382.901762] Starting dynamic subtest: pipe-C-eDP-1-size-64
[385.701885] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.816s)
[385.739060] Starting dynamic subtest: pipe-C-eDP-1-size-128
[387.813879] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.080s)
[387.851806] Starting dynamic subtest: pipe-C-eDP-1-size-256
[389.970167] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.125s)
[390.297750] Starting dynamic subtest: pipe-D-eDP-1-size-64
[393.106075] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.817s)
[393.144275] Starting dynamic subtest: pipe-D-eDP-1-size-128
[395.351933] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.213s)
[395.389114] Starting dynamic subtest: pipe-D-eDP-1-size-256
[397.486102] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[397.808566] Subtest viewport: SUCCESS (31.815s)
[398.614852] [076/133] (623s left) gem_exec_whisper (basic-fds)
[398.685606] Starting subtest: basic-fds
[404.262090] Subtest basic-fds: SUCCESS (5.574s)
[404.446711] [077/133] (617s left) kms_psr (psr-cursor-mmap-cpu)
[404.549966] Starting subtest: psr-cursor-mmap-cpu
[404.552193] Starting dynamic subtest: eDP-1
[406.299980] Dynamic subtest eDP-1: SUCCESS (1.750s)
[406.302540] Subtest psr-cursor-mmap-cpu: SUCCESS (1.751s)
[407.180023] [078/133] (614s left) gem_ctx_persistence (engines-persistence)
[407.244412] Starting subtest: engines-persistence
[407.247408] Starting dynamic subtest: rcs0
[408.040228] Dynamic subtest rcs0: SUCCESS (0.796s)
[408.052723] Starting dynamic subtest: bcs0
[408.793677] Dynamic subtest bcs0: SUCCESS (0.751s)
[408.804280] Starting dynamic subtest: vcs0
[409.564041] Dynamic subtest vcs0: SUCCESS (0.768s)
[409.575516] Starting dynamic subtest: vcs1
[410.342498] Dynamic subtest vcs1: SUCCESS (0.776s)
[410.354970] Starting dynamic subtest: vecs0
[411.107888] Dynamic subtest vecs0: SUCCESS (0.763s)
[411.118461] Starting dynamic subtest: ccs0
[411.880727] Dynamic subtest ccs0: SUCCESS (0.770s)
[411.883502] Subtest engines-persistence: SUCCESS (4.638s)
[411.966534] [079/133] (610s left) syncobj_eventfd (invalid-bad-pad)
[412.033334] Starting subtest: invalid-bad-pad
[412.036444] Subtest invalid-bad-pad: SUCCESS (0.000s)
[412.135985] [080/133] (609s left) kms_flip (absolute-wf_vblank)
[412.237839] Starting subtest: absolute-wf_vblank
[412.240512] Starting dynamic subtest: A-eDP1
[421.059925] Dynamic subtest A-eDP1: SUCCESS (8.793s)
[421.070927] Starting dynamic subtest: B-eDP1
[429.752491] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[429.765080] Starting dynamic subtest: C-eDP1
[438.512675] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[438.524368] Starting dynamic subtest: D-eDP1
[447.217866] Dynamic subtest D-eDP1: SUCCESS (8.753s)
[447.222499] Subtest absolute-wf_vblank: SUCCESS (34.999s)
[448.429359] [081/133] (573s left) gem_pxp (fail-invalid-protected-context)
[448.534337] Starting subtest: fail-invalid-protected-context
[448.537006] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[448.642772] [082/133] (573s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[448.738663] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[448.742944] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[449.869835] [083/133] (572s left) kms_big_fb (linear-16bpp-rotate-90)
[449.969173] Starting subtest: linear-16bpp-rotate-90
[449.989343] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[450.089184] [084/133] (572s left) gem_exec_reloc (basic-softpin)
[450.145354] Subtest basic-softpin: SKIP (0.000s)
[450.210627] [085/133] (572s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[450.315476] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[450.320475] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[450.405797] [086/133] (571s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[450.527360] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[450.532021] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[450.674322] [087/133] (571s left) prime_self_import (basic-llseek-size)
[450.712217] Starting subtest: basic-llseek-size
[450.739155] Subtest basic-llseek-size: SUCCESS (0.025s)
[450.852953] [088/133] (571s left) perf_pmu (semaphore-wait-idle)
[450.893443] Starting subtest: semaphore-wait-idle
[450.895755] Starting dynamic subtest: rcs0
[451.407090] Dynamic subtest rcs0: SUCCESS (0.513s)
[451.418135] Starting dynamic subtest: bcs0
[451.921719] Dynamic subtest bcs0: SUCCESS (0.511s)
[451.934064] Starting dynamic subtest: vcs0
[452.435946] Dynamic subtest vcs0: SUCCESS (0.510s)
[452.447511] Starting dynamic subtest: vcs1
[452.950820] Dynamic subtest vcs1: SUCCESS (0.511s)
[452.961584] Starting dynamic subtest: vecs0
[453.465558] Dynamic subtest vecs0: SUCCESS (0.510s)
[453.477599] Starting dynamic subtest: ccs0
[453.980753] Dynamic subtest ccs0: SUCCESS (0.512s)
[453.983653] Subtest semaphore-wait-idle: SUCCESS (3.087s)
[455.213316] [089/133] (567s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[455.319306] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[455.324270] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[455.410409] [090/133] (567s left) sw_sync (alloc_fence_invalid_timeline)
[455.452313] Starting subtest: alloc_fence_invalid_timeline
[455.454772] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[455.511023] [091/133] (567s left) gem_mmap_offset (mmap-boundaries)
[455.573209] Starting subtest: mmap-boundaries
[455.575958] Starting dynamic subtest: smem0
[455.848825] Dynamic subtest smem0: SUCCESS (0.278s)
[455.851736] Subtest mmap-boundaries: SUCCESS (0.279s)
[455.977708] [092/133] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[456.075337] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[456.081121] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[456.190769] [093/133] (566s left) gen3_render_mixed_blits
[456.302058] [094/133] (566s left) gem_fence_thrash (bo-write-verify-x)
[456.346807] Starting subtest: bo-write-verify-x
[456.360234] Subtest bo-write-verify-x: SKIP (0.012s)
[456.424154] [095/133] (566s left) gem_lmem_swapping (verify-random)
[456.463074] Subtest verify-random: SKIP (0.000s)
[456.506041] [096/133] (566s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[456.600262] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[456.605040] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[456.699401] [097/133] (566s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[456.782366] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[456.787654] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[456.854458] [098/133] (565s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[456.955325] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[456.959775] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[457.036005] [099/133] (565s left) kms_cursor_crc (cursor-onscreen-256x256)
[457.292103] Starting subtest: cursor-onscreen-256x256
[457.294787] Starting dynamic subtest: pipe-A-eDP-1
[459.427610] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.132s)
[459.459259] Starting dynamic subtest: pipe-D-eDP-1
[462.253269] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.803s)
[462.255497] Subtest cursor-onscreen-256x256: SUCCESS (4.962s)
[463.051867] [100/133] (559s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[463.178792] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[463.230832] [101/133] (559s left) i915_query (query-regions-unallocated)
[463.284449] Starting subtest: query-regions-unallocated
[463.287200] Subtest query-regions-unallocated: SUCCESS (0.000s)
[463.404769] [102/133] (559s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[463.505280] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[463.510373] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[463.608991] [103/133] (559s left) kms_psr (fbc-psr-cursor-plane-move)
[463.697145] Starting subtest: fbc-psr-cursor-plane-move
[463.699630] Starting dynamic subtest: eDP-1
[463.704049] Dynamic subtest eDP-1: SKIP (0.000s)
[463.708636] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[463.769149] [104/133] (559s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[463.869287] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[463.874261] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[463.961828] [105/133] (559s left) gem_exec_schedule (submit-golden-slice)
[464.020829] Starting subtest: submit-golden-slice
[464.022629] Starting dynamic subtest: rcs0
[464.050196] Dynamic subtest rcs0: SUCCESS (0.036s)
[464.059933] Starting dynamic subtest: bcs0
[464.078571] Dynamic subtest bcs0: SUCCESS (0.027s)
[464.088775] Starting dynamic subtest: vcs0
[464.112325] Dynamic subtest vcs0: SUCCESS (0.033s)
[464.121227] Starting dynamic subtest: vcs1
[464.149739] Dynamic subtest vcs1: SUCCESS (0.037s)
[464.158759] Starting dynamic subtest: vecs0
[464.183081] Dynamic subtest vecs0: SUCCESS (0.033s)
[464.192129] Starting dynamic subtest: ccs0
[464.211744] Dynamic subtest ccs0: SUCCESS (0.027s)
[464.214093] Subtest submit-golden-slice: SUCCESS (0.198s)
[465.269142] [106/133] (557s left) kms_content_protection (suspend-resume)
[465.409676] Starting subtest: suspend-resume
[465.415385] Subtest suspend-resume: SKIP (0.000s)
[465.520129] [107/133] (557s left) api_intel_bb (render)
[465.570206] Starting subtest: render
[465.572931] Starting dynamic subtest: render-none-512
[465.669194] Dynamic subtest render-none-512: SUCCESS (0.101s)
[465.681336] Starting dynamic subtest: render-none-1024
[466.044151] Dynamic subtest render-none-1024: SUCCESS (0.372s)
[466.056494] Starting dynamic subtest: render-x-512
[466.127628] Dynamic subtest render-x-512: SUCCESS (0.084s)
[466.140260] Starting dynamic subtest: render-x-1024
[466.472395] Dynamic subtest render-x-1024: SUCCESS (0.343s)
[466.484473] Starting dynamic subtest: render-y-512
[466.557146] Dynamic subtest render-y-512: SUCCESS (0.085s)
[466.569070] Starting dynamic subtest: render-y-1024
[466.892099] Dynamic subtest render-y-1024: SUCCESS (0.333s)
[466.895356] Subtest render: SUCCESS (1.323s)
[467.011863] [108/133] (556s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[467.108603] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[467.111228] Starting dynamic subtest: pipe-A-eDP-1
[467.136901] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[467.152019] Starting dynamic subtest: pipe-B-eDP-1
[467.178170] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[467.188452] Starting dynamic subtest: pipe-C-eDP-1
[467.211598] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[467.221137] Starting dynamic subtest: pipe-D-eDP-1
[467.244462] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[467.249454] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[469.429547] [109/133] (553s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[469.527299] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[469.532508] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[470.661849] [110/133] (552s left) kms_rotation_crc (primary-rotation-180)
[470.757409] Starting subtest: primary-rotation-180
[477.914648] Subtest primary-rotation-180: SUCCESS (7.159s)
[479.112976] [111/133] (544s left) perf_pmu (init-wait)
[479.161114] Starting subtest: init-wait
[479.163646] Starting dynamic subtest: rcs0
[479.166184] Dynamic subtest rcs0: SUCCESS (0.002s)
[479.175410] Starting dynamic subtest: bcs0
[479.177893] Dynamic subtest bcs0: SUCCESS (0.000s)
[479.186926] Starting dynamic subtest: vcs0
[479.189211] Dynamic subtest vcs0: SUCCESS (0.000s)
[479.197943] Starting dynamic subtest: vcs1
[479.200233] Dynamic subtest vcs1: SUCCESS (0.000s)
[479.209277] Starting dynamic subtest: vecs0
[479.211281] Dynamic subtest vecs0: SUCCESS (0.000s)
[479.220254] Starting dynamic subtest: ccs0
[479.222584] Dynamic subtest ccs0: SUCCESS (0.000s)
[479.225064] Subtest init-wait: SUCCESS (0.008s)
[479.266450] [112/133] (544s left) gem_exec_reloc (basic-gtt-cpu-active)
[479.322878] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[479.386877] [113/133] (544s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[479.760387] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[480.541284] [114/133] (542s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[480.921925] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[481.770073] [115/133] (541s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[481.875736] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[481.880265] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[481.979902] [116/133] (541s left) i915_pm_rc6_residency (media-rc6-accuracy)
[482.034594] Starting subtest: media-rc6-accuracy
[482.039907] Subtest media-rc6-accuracy: SKIP (0.000s)
[482.131250] [117/133] (541s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[482.247460] Starting subtest: 2x-long-flip-vs-cursor-legacy
[482.252157] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[482.402826] [118/133] (541s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[482.489347] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[482.515052] Starting dynamic subtest: pipe-A-plane-0
[482.805054] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[482.814277] Starting dynamic subtest: pipe-A-plane-3
[483.048018] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[483.057494] Starting dynamic subtest: pipe-A-plane-5
[483.062086] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[484.177790] Starting dynamic subtest: pipe-B-plane-0
[484.470404] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[484.480376] Starting dynamic subtest: pipe-B-plane-3
[484.704164] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[484.713321] Starting dynamic subtest: pipe-B-plane-5
[484.717833] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[485.012701] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.524s)
[485.850711] [119/133] (537s left) syncobj_timeline (invalid-query-zero-handles)
[485.907262] Starting subtest: invalid-query-zero-handles
[485.910030] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[486.020235] [120/133] (537s left) kms_big_fb (4-tiled-addfb)
[486.124256] Starting subtest: 4-tiled-addfb
[486.126765] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[486.215294] [121/133] (537s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[486.304102] Starting subtest: 2x-plain-flip-ts-check-interruptible
[486.315273] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[486.394141] [122/133] (537s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[486.487592] Starting subtest: pr-overlay-plane-update-continuous-sf
[486.492488] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[486.555718] [123/133] (537s left) kms_pipe_crc_basic (read-crc)
[486.650151] Starting subtest: read-crc
[486.652873] Starting dynamic subtest: pipe-A-eDP-1
[487.337400] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[487.357346] Starting dynamic subtest: pipe-B-eDP-1
[488.728037] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[488.738312] Starting dynamic subtest: pipe-C-eDP-1
[490.130507] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.402s)
[490.140496] Starting dynamic subtest: pipe-D-eDP-1
[491.461210] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[491.464149] Subtest read-crc: SUCCESS (4.813s)
[492.282059] [124/133] (531s left) kms_chamelium_audio (dp-audio-edid)
[492.658046] Subtest dp-audio-edid: SKIP (0.000s)
[493.494962] [125/133] (530s left) kms_fbcon_fbt (fbc)
[493.548147] Starting subtest: fbc
[499.838162] Subtest fbc: SUCCESS (6.290s)
[500.927160] [126/133] (523s left) gem_userptr_blits (unsync-unmap)
[500.999832] Subtest unsync-unmap: SKIP (0.000s)
[501.108271] [127/133] (522s left) kms_properties (plane-properties-atomic)
[501.202264] Starting subtest: plane-properties-atomic
[501.204938] Starting dynamic subtest: pipe-A-eDP-1
[501.770364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[501.781448] Starting dynamic subtest: pipe-B-eDP-1
[503.037468] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.266s)
[503.050381] Starting dynamic subtest: pipe-C-eDP-1
[504.277057] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[504.289309] Starting dynamic subtest: pipe-D-eDP-1
[505.512321] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[505.515136] Subtest plane-properties-atomic: SUCCESS (4.311s)
[506.312343] [128/133] (517s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[506.414310] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[506.419915] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[506.509998] [129/133] (517s left) kms_atomic_interruptible (legacy-pageflip)
[506.599236] Starting subtest: legacy-pageflip
[506.601832] Starting dynamic subtest: pipe-A-eDP-1
[514.047058] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.446s)
[514.049739] Subtest legacy-pageflip: SUCCESS (7.447s)
[514.886973] [130/133] (509s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[514.982809] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[514.985127] Starting dynamic subtest: pipe-A-default-mode
[516.143463] Dynamic subtest pipe-A-default-mode: SKIP (1.159s)
[516.150408] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.161s)
[516.279109] [131/133] (507s left) sysfs_heartbeat_interval (idempotent)
[516.336930] Starting subtest: idempotent
[516.339392] Starting dynamic subtest: vecs0
[516.341900] Dynamic subtest vecs0: SUCCESS (0.001s)
[516.353119] Starting dynamic subtest: ccs0
[516.355358] Dynamic subtest ccs0: SUCCESS (0.001s)
[516.364393] Starting dynamic subtest: vcs0
[516.366567] Dynamic subtest vcs0: SUCCESS (0.000s)
[516.374809] Starting dynamic subtest: bcs0
[516.376890] Dynamic subtest bcs0: SUCCESS (0.001s)
[516.385477] Starting dynamic subtest: rcs0
[516.387362] Dynamic subtest rcs0: SUCCESS (0.000s)
[516.396024] Starting dynamic subtest: vcs1
[516.398348] Dynamic subtest vcs1: SUCCESS (0.000s)
[516.400613] Subtest idempotent: SUCCESS (0.008s)
[516.456528] [132/133] (507s left) kms_pm_rpm (system-suspend-modeset)
[518.290378] Starting subtest: system-suspend-modeset
[538.281316] Subtest system-suspend-modeset: SUCCESS (4.324s)
[538.660916] [133/133] (485s left) gem_vm_create (invalid-destroy)
[538.718814] Starting subtest: invalid-destroy
[538.721142] Subtest invalid-destroy: SUCCESS (0.002s)
[538.826278] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: gem_unfence_active_buffers
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_fence_thrash
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: gem_ctx_param
results: parsing output: 7/ for test: kms_getfb
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: gem_ctx_engines
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_pm_rpm
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_spin_batch
results: parsing output: 16/ for test: gen9_exec_parse
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: tools_test
results: parsing output: 24/ for test: gem_exec_schedule
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: gem_exec_parallel
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_flink_basic
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_exec_params
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_lease
results: parsing output: 57/ for test: gem_ctx_shared
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: gem_pxp
results: parsing output: 61/ for test: gem_userptr_blits
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: i915_hangman
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_hdr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: device_reset
results: parsing output: 71/ for test: gem_busy
results: parsing output: 72/ for test: kms_panel_fitting
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: kms_plane_cursor
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: syncobj_eventfd
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: prime_self_import
results: parsing output: 87/ for test: perf_pmu
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: gem_mmap_offset
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gen3_render_mixed_blits
results: parsing output: 93/ for test: gem_fence_thrash
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_tiled_display
results: parsing output: 100/ for test: i915_query
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_content_protection
results: parsing output: 106/ for test: api_intel_bb
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_rotation_crc
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_pm_rc6_residency
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_pipe_crc_basic
results: parsing output: 123/ for test: kms_chamelium_audio
results: parsing output: 124/ for test: kms_fbcon_fbt
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: kms_properties
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_atomic_interruptible
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: sysfs_heartbeat_interval
results: parsing output: 131/ for test: kms_pm_rpm
results: parsing output: 132/ for test: gem_vm_create
Done.