[61.741126] Initializing watchdogs
[61.741174]   /dev/watchdog0
[61.755126] [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]
[61.759448] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.761770] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.765292] [001/132] (960s left) kms_psr (pr-cursor-plane-onoff)
[61.886103] Starting subtest: pr-cursor-plane-onoff
[61.890567] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[61.954844] [002/132] (960s left) kms_plane (pixel-format-x-tiled-modifier)
[62.046621] Starting subtest: pixel-format-x-tiled-modifier
[62.082493] Starting dynamic subtest: pipe-A-plane-0
[62.728454] Dynamic subtest pipe-A-plane-0: SUCCESS (0.645s)
[62.737301] Starting dynamic subtest: pipe-A-plane-3
[63.128920] Dynamic subtest pipe-A-plane-3: SUCCESS (0.399s)
[63.135520] Starting dynamic subtest: pipe-A-plane-5
[63.138935] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[64.195632] Starting dynamic subtest: pipe-B-plane-0
[64.834682] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[64.841898] Starting dynamic subtest: pipe-B-plane-3
[65.246102] Dynamic subtest pipe-B-plane-3: SUCCESS (0.411s)
[65.252955] Starting dynamic subtest: pipe-B-plane-5
[65.256573] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[65.557038] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.503s)
[66.372464] [003/132] (955s left) kms_flip (2x-nonexisting-fb-interruptible)
[66.460891] Starting subtest: 2x-nonexisting-fb-interruptible
[66.471832] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[66.581561] [004/132] (955s left) kms_psr (fbc-psr2-sprite-render)
[66.677680] Starting subtest: fbc-psr2-sprite-render
[66.679872] Starting dynamic subtest: eDP-1
[66.684205] Dynamic subtest eDP-1: SKIP (0.000s)
[66.688587] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[66.748829] [005/132] (955s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[66.906408] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[66.910725] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[67.284253] [006/132] (955s left) kms_psr (psr-cursor-render)
[67.505265] Starting subtest: psr-cursor-render
[67.507702] Starting dynamic subtest: eDP-1
[69.283594] Dynamic subtest eDP-1: SUCCESS (1.778s)
[69.286053] Subtest psr-cursor-render: SUCCESS (1.778s)
[70.143730] [007/132] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[70.243218] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[70.247550] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[70.328235] [008/132] (952s left) i915_drm_fdinfo (virtual-idle)
[70.371738] Starting subtest: virtual-idle
[73.410946] Subtest virtual-idle: SUCCESS (3.032s)
[73.477806] [009/132] (949s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[73.577740] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[73.582281] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[73.683702] [010/132] (948s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[73.748629] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[73.858779] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.109s)
[73.942642] [011/132] (948s left) kms_atomic (plane-immutable-zpos)
[74.041251] Starting subtest: plane-immutable-zpos
[74.043451] Starting dynamic subtest: pipe-A-eDP-1
[74.712630] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.668s)
[74.714843] Subtest plane-immutable-zpos: SUCCESS (0.669s)
[75.578547] [012/132] (947s left) drm_read (empty-block)
[75.726093] Starting subtest: empty-block
[76.726688] Subtest empty-block: SUCCESS (1.000s)
[76.867711] [013/132] (945s left) gem_pxp (hw-rejects-pxp-context)
[76.989567] Starting subtest: hw-rejects-pxp-context
[76.994324] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[77.090327] [014/132] (945s left) perf (global-sseu-config)
[77.212020] Starting subtest: global-sseu-config
[77.216418] Subtest global-sseu-config: SKIP (0.000s)
[77.256302] [015/132] (945s left) kms_hdmi_inject (inject-4k)
[78.326631] Starting subtest: inject-4k
[78.637835] Subtest inject-4k: SUCCESS (0.313s)
[79.033665] [016/132] (943s left) gem_exec_schedule (submit-early-slice)
[79.097632] Starting subtest: submit-early-slice
[79.099795] Starting dynamic subtest: rcs0
[79.126407] Dynamic subtest rcs0: SUCCESS (0.033s)
[79.134052] Starting dynamic subtest: bcs0
[79.165945] Dynamic subtest bcs0: SUCCESS (0.039s)
[79.176943] Starting dynamic subtest: vcs0
[79.202325] Dynamic subtest vcs0: SUCCESS (0.036s)
[79.213638] Starting dynamic subtest: vcs1
[79.237915] Dynamic subtest vcs1: SUCCESS (0.035s)
[79.246660] Starting dynamic subtest: vecs0
[79.275507] Dynamic subtest vecs0: SUCCESS (0.037s)
[79.283275] Starting dynamic subtest: ccs0
[79.307349] Dynamic subtest ccs0: SUCCESS (0.032s)
[79.309663] Subtest submit-early-slice: SUCCESS (0.215s)
[81.005754] [017/132] (941s left) kms_cursor_crc (cursor-onscreen-64x21)
[81.196099] Starting subtest: cursor-onscreen-64x21
[81.246241] Subtest cursor-onscreen-64x21: SKIP (0.047s)
[81.455746] [018/132] (941s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[81.577958] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[92.759256] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.178s)
[93.627321] [019/132] (929s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[93.726892] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[93.731141] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[93.816415] [020/132] (929s left) kms_flip (flip-vs-suspend)
[93.904280] Starting subtest: flip-vs-suspend
[93.906506] Starting dynamic subtest: A-eDP1
[143.214236] Dynamic subtest A-eDP1: SUCCESS (4.709s)
[143.223077] Starting dynamic subtest: B-eDP1
[192.211199] Dynamic subtest B-eDP1: SUCCESS (4.463s)
[192.220883] Starting dynamic subtest: C-eDP1
[241.211833] Dynamic subtest C-eDP1: SUCCESS (4.495s)
[241.225709] Starting dynamic subtest: D-eDP1
[290.206100] Dynamic subtest D-eDP1: SUCCESS (4.492s)
[290.208424] Subtest flip-vs-suspend: SUCCESS (18.169s)
[291.408153] [021/132] (731s left) api_intel_bb (intel-bb-blit-x)
[291.473477] Starting subtest: intel-bb-blit-x
[295.699627] Subtest intel-bb-blit-x: SUCCESS (4.206s)
[295.824394] [022/132] (727s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[295.921415] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[296.294021] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[299.066808] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.763s)
[299.078129] Starting dynamic subtest: pipe-A-eDP-1-4
[301.246851] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.175s)
[301.258129] Starting dynamic subtest: pipe-A-eDP-1-4
[303.260586] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[303.269768] Starting dynamic subtest: pipe-A-eDP-1-x
[305.454023] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[305.820549] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[308.582972] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.764s)
[308.591505] Starting dynamic subtest: pipe-B-eDP-1-4
[310.758940] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[310.769842] Starting dynamic subtest: pipe-B-eDP-1-4
[312.770962] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[312.779776] Starting dynamic subtest: pipe-B-eDP-1-x
[314.963712] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[315.332445] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[318.083054] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.755s)
[318.094269] Starting dynamic subtest: pipe-C-eDP-1-4
[320.258841] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[320.268695] Starting dynamic subtest: pipe-C-eDP-1-4
[322.269849] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (1.995s)
[322.281209] Starting dynamic subtest: pipe-C-eDP-1-x
[324.454024] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s)
[324.823310] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[327.615985] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.785s)
[327.627662] Starting dynamic subtest: pipe-D-eDP-1-4
[329.788835] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.164s)
[329.800310] Starting dynamic subtest: pipe-D-eDP-1-4
[331.795199] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (1.999s)
[331.805993] Starting dynamic subtest: pipe-D-eDP-1-x
[333.968760] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.168s)
[333.971241] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (37.952s)
[335.206373] [023/132] (687s left) syncobj_timeline (wait-all-snapshot)
[335.260046] Starting subtest: wait-all-snapshot
[335.340208] Subtest wait-all-snapshot: SUCCESS (0.081s)
[335.417994] [024/132] (687s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[335.508895] Starting subtest: plane-lut1d-pre-ctm3x4
[335.688677] Starting dynamic subtest: pipe-A-plane-0
[335.877682] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[335.886150] Starting dynamic subtest: pipe-A-plane-1
[336.078255] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[336.093782] Starting dynamic subtest: pipe-A-plane-2
[336.222642] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[337.394251] Starting dynamic subtest: pipe-B-plane-0
[337.549323] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[337.557995] Starting dynamic subtest: pipe-B-plane-1
[337.694616] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[337.702712] Starting dynamic subtest: pipe-B-plane-2
[337.827530] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[338.979440] Starting dynamic subtest: pipe-C-plane-0
[339.106117] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[339.114861] Starting dynamic subtest: pipe-C-plane-1
[339.250578] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[339.259293] Starting dynamic subtest: pipe-C-plane-2
[339.395435] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[340.571545] Starting dynamic subtest: pipe-D-plane-0
[340.720708] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[340.729044] Starting dynamic subtest: pipe-D-plane-1
[340.865281] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[340.873991] Starting dynamic subtest: pipe-D-plane-2
[341.009981] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[341.315464] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.798s)
[342.120499] [025/132] (681s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[342.221083] Starting subtest: x-tiled-16bpp-rotate-0
[343.477243] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.256s)
[343.614103] [026/132] (679s left) sw_sync (alloc_merge_fence)
[343.651997] Starting subtest: alloc_merge_fence
[343.653605] Subtest alloc_merge_fence: SUCCESS (0.000s)
[343.704316] [027/132] (679s left) syncobj_wait (multi-wait-all-submitted-signaled)
[343.758407] Starting subtest: multi-wait-all-submitted-signaled
[343.865122] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.105s)
[343.938899] [028/132] (679s left) api_intel_allocator (two-level-inception)
[343.989252] Starting subtest: two-level-inception
[349.391145] Subtest two-level-inception: SUCCESS (5.398s)
[349.519239] [029/132] (673s left) kms_flip (2x-flip-vs-panning-interruptible)
[349.628038] Starting subtest: 2x-flip-vs-panning-interruptible
[349.646156] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.018s)
[349.726341] [030/132] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[349.825344] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[349.829504] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[349.940361] [031/132] (673s left) prime_vgem (sync)
[350.117290] Starting subtest: sync
[350.119604] Starting dynamic subtest: rcs0
[350.171919] Dynamic subtest rcs0: SUCCESS (0.055s)
[350.179848] Starting dynamic subtest: bcs0
[350.246950] Dynamic subtest bcs0: SUCCESS (0.074s)
[350.255009] Starting dynamic subtest: vcs0
[350.295075] Dynamic subtest vcs0: SUCCESS (0.047s)
[350.303085] Starting dynamic subtest: vcs1
[350.341410] Dynamic subtest vcs1: SUCCESS (0.045s)
[350.349482] Starting dynamic subtest: vecs0
[350.388347] Dynamic subtest vecs0: SUCCESS (0.046s)
[350.396401] Starting dynamic subtest: ccs0
[350.434758] Dynamic subtest ccs0: SUCCESS (0.046s)
[350.436589] Subtest sync: SUCCESS (0.319s)
[350.565465] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[350.569490] [032/132] (672s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[350.683122] Starting subtest: yf-tiled-16bpp-rotate-90
[350.686890] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[350.812306] [033/132] (672s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[350.909929] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[350.911768] Starting dynamic subtest: pipe-A-eDP-1
[351.048432] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.132s)
[351.059446] Starting dynamic subtest: pipe-B-eDP-1
[351.076983] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[351.086502] Starting dynamic subtest: pipe-C-eDP-1
[351.101736] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[351.109175] Starting dynamic subtest: pipe-D-eDP-1
[351.124525] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[351.126283] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.141s)
[353.427374] [034/132] (670s left) gem_userptr_blits (invalid-null-pointer)
[353.505187] Starting subtest: invalid-null-pointer
[353.507439] Subtest invalid-null-pointer: SUCCESS (0.002s)
[353.649106] [035/132] (669s left) gem_ctx_exec (basic-invalid-context)
[353.698076] Starting subtest: basic-invalid-context
[353.702536] Subtest basic-invalid-context: SUCCESS (0.005s)
[353.815770] [036/132] (669s left) kms_setmode (invalid-clone-single-crtc)
[353.859961] Starting subtest: invalid-clone-single-crtc
[353.865915] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[353.956844] [037/132] (669s left) kms_big_fb (linear-64bpp-rotate-180)
[354.084820] Starting subtest: linear-64bpp-rotate-180
[355.785535] Subtest linear-64bpp-rotate-180: SUCCESS (1.701s)
[355.957358] [038/132] (667s left) gem_linear_blits (basic)
[356.364006] Starting subtest: basic
[356.372450] Subtest basic: SUCCESS (0.010s)
[356.527629] [039/132] (667s left) kms_pm_backlight (fade-with-suspend)
[356.666364] Starting subtest: fade-with-suspend
[373.183885] Starting dynamic subtest: eDP-1
[375.666448] Dynamic subtest eDP-1: SUCCESS (2.454s)
[375.669046] Subtest fade-with-suspend: SUCCESS (3.715s)
[376.512102] [040/132] (647s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[376.611222] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[376.615790] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[376.681122] [041/132] (647s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[376.739668] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[376.742023] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[376.812729] [042/132] (647s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[377.025424] Starting subtest: cursor-rapid-movement-128x128
[377.030359] Starting dynamic subtest: pipe-A-eDP-1
[377.583020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[377.612532] Starting dynamic subtest: pipe-D-eDP-1
[378.825317] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[378.827726] Subtest cursor-rapid-movement-128x128: SUCCESS (1.779s)
[379.665175] [043/132] (644s left) kms_cursor_legacy (forked-move)
[379.785123] Starting subtest: forked-move
[379.787457] Starting dynamic subtest: pipe-A
[385.285456] Dynamic subtest pipe-A: SUCCESS (5.464s)
[385.302354] Starting dynamic subtest: pipe-B
[390.778500] Dynamic subtest pipe-B: SUCCESS (5.472s)
[390.797778] Starting dynamic subtest: pipe-C
[396.252912] Dynamic subtest pipe-C: SUCCESS (5.463s)
[396.270863] Starting dynamic subtest: pipe-D
[401.728716] Dynamic subtest pipe-D: SUCCESS (5.467s)
[401.740340] Starting dynamic subtest: all-pipes
[407.218990] Dynamic subtest all-pipes: SUCCESS (5.485s)
[407.221563] Subtest forked-move: SUCCESS (27.364s)
[407.360287] [044/132] (616s left) kms_plane_lowres (tiling-none)
[407.468779] Starting subtest: tiling-none
[407.471024] Starting dynamic subtest: pipe-A-eDP-1
[407.475651] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[407.762377] Starting dynamic subtest: pipe-B-eDP-1
[407.767050] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[407.775453] Starting dynamic subtest: pipe-C-eDP-1
[407.780137] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[407.788340] Starting dynamic subtest: pipe-D-eDP-1
[407.792544] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[407.796755] Subtest tiling-none: SKIP (0.292s)
[408.607574] [045/132] (615s left) i915_suspend (fence-restore-tiled2untiled)
[408.671105] Starting subtest: fence-restore-tiled2untiled
[408.675503] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[408.763904] [046/132] (615s left) kms_big_fb (y-tiled-addfb-size-overflow)
[408.856213] Starting subtest: y-tiled-addfb-size-overflow
[408.860617] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[408.953582] [047/132] (615s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[409.044495] Starting subtest: pr-plane-move-sf-dmg-area
[409.048675] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[409.110714] [048/132] (614s left) prime_self_import (basic-with_one_bo_two_files)
[409.153626] Starting subtest: basic-with_one_bo_two_files
[409.174532] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s)
[409.271771] [049/132] (614s left) gem_exec_schedule (preempt-queue)
[409.352767] Subtest preempt-queue: SKIP (0.000s)
[409.635239] [050/132] (614s left) sw_sync (sync_multi_timeline_wait)
[409.668142] Starting subtest: sync_multi_timeline_wait
[409.670500] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[409.722172] [051/132] (614s left) kms_psr (psr2-primary-mmap-gtt)
[409.822622] Starting subtest: psr2-primary-mmap-gtt
[409.824929] Starting dynamic subtest: eDP-1
[411.274605] Dynamic subtest eDP-1: SKIP (1.447s)
[411.279221] Subtest psr2-primary-mmap-gtt: SKIP (1.449s)
[411.381871] [052/132] (612s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[411.446667] Starting subtest: invalid-bsd2-flag-on-vebox
[411.448621] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[411.543463] [053/132] (612s left) gem_busy (parallel)
[411.739916] Starting subtest: parallel
[411.742461] Starting dynamic subtest: rcs0
[413.162912] Dynamic subtest rcs0: SUCCESS (1.421s)
[413.174538] Starting dynamic subtest: bcs0
[415.147474] Dynamic subtest bcs0: SUCCESS (1.981s)
[415.159341] Starting dynamic subtest: vcs0
[417.130632] Dynamic subtest vcs0: SUCCESS (1.979s)
[417.142746] Starting dynamic subtest: vcs1
[419.178102] Dynamic subtest vcs1: SUCCESS (2.044s)
[419.191521] Starting dynamic subtest: vecs0
[421.163095] Dynamic subtest vecs0: SUCCESS (1.981s)
[421.175354] Starting dynamic subtest: ccs0
[423.147496] Dynamic subtest ccs0: SUCCESS (1.980s)
[423.150417] Subtest parallel: SUCCESS (11.405s)
[423.392153] [054/132] (600s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[423.485328] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[423.489551] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[423.556532] [055/132] (600s left) gem_exec_reloc (basic-concurrent0)
[423.612003] Subtest basic-concurrent0: SKIP (0.000s)
[423.682658] [056/132] (600s left) gem_render_copy (y-tiled-to-vebox-linear)
[423.736848] Starting subtest: y-tiled-to-vebox-linear
[423.741203] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[423.919292] [057/132] (600s left) kms_sequence (queue-idle)
[424.012168] Starting subtest: queue-idle
[424.014491] Starting dynamic subtest: pipe-A-eDP-1
[425.827531] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[425.837431] Starting dynamic subtest: pipe-B-eDP-1
[428.300255] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.472s)
[428.309005] Starting dynamic subtest: pipe-C-eDP-1
[430.746855] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.441s)
[430.756064] Starting dynamic subtest: pipe-D-eDP-1
[433.261947] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.513s)
[433.264261] Subtest queue-idle: SUCCESS (9.247s)
[434.109638] [058/132] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[434.207646] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[434.211772] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[434.303765] [059/132] (590s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[434.398067] Starting subtest: primary-y-tiled-reflect-x-180
[434.456702] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[434.582194] [060/132] (589s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[434.682282] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[438.210992] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.531s)
[439.323954] [061/132] (585s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[439.422475] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[439.426527] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[439.508514] [062/132] (585s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[439.606550] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[439.608827] Starting dynamic subtest: pipe-A-eDP-1
[439.630923] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[439.641704] Starting dynamic subtest: pipe-B-eDP-1
[439.662221] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[439.670344] Starting dynamic subtest: pipe-C-eDP-1
[439.690960] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[439.699155] Starting dynamic subtest: pipe-D-eDP-1
[439.719858] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[439.723894] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[441.811093] [063/132] (582s left) gem_mmap_offset (oob-read)
[441.866722] Starting subtest: oob-read
[441.868861] Subtest oob-read: SUCCESS (0.000s)
[441.984636] [064/132] (582s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[442.083959] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[442.088480] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[443.212882] [065/132] (581s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[443.317127] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[443.319533] Starting dynamic subtest: pipe-A-eDP-1
[443.343974] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[443.355259] Starting dynamic subtest: pipe-B-eDP-1
[443.378729] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[443.387767] Starting dynamic subtest: pipe-C-eDP-1
[443.411318] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[443.422564] Starting dynamic subtest: pipe-D-eDP-1
[443.448226] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[443.452411] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[445.515249] [066/132] (579s left) gem_exec_capture (capture-recoverable)
[445.586061] Starting subtest: capture-recoverable
[445.588375] Subtest capture-recoverable: SUCCESS (0.003s)
[445.710315] [067/132] (579s left) kms_draw_crc (draw-method-blt)
[445.804848] Starting subtest: draw-method-blt
[445.806735] Starting dynamic subtest: xrgb8888-untiled
[446.024751] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[446.033955] Starting dynamic subtest: rgb565-untiled
[446.236331] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[446.246909] Starting dynamic subtest: xrgb2101010-untiled
[446.447128] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[446.463598] Starting dynamic subtest: xbgr16161616f-untiled
[446.648398] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[446.657235] Starting dynamic subtest: xrgb8888-xtiled
[446.769109] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.119s)
[446.777796] Starting dynamic subtest: rgb565-xtiled
[446.880226] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[446.888889] Starting dynamic subtest: xrgb2101010-xtiled
[446.980896] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[446.989305] Starting dynamic subtest: xbgr16161616f-xtiled
[447.080507] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[447.088958] Starting dynamic subtest: xrgb8888-4tiled
[447.191569] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[447.200028] Starting dynamic subtest: rgb565-4tiled
[447.302601] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[447.311374] Starting dynamic subtest: xrgb2101010-4tiled
[447.402559] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[447.411137] Starting dynamic subtest: xbgr16161616f-4tiled
[447.502984] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[447.504767] Subtest draw-method-blt: SUCCESS (1.700s)
[447.605784] [068/132] (577s left) gem_userptr_blits (coherency-unsync)
[447.663092] Subtest coherency-unsync: SKIP (0.000s)
[447.785934] [069/132] (577s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[447.848120] Starting subtest: invalid-bsd1-flag-on-blt
[447.850207] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[447.972662] [070/132] (576s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[448.022418] Starting subtest: multi-wait-all-available-submitted-signaled
[448.024474] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[448.122851] [071/132] (576s left) gem_lmem_swapping (parallel-random-engines)
[448.171009] Subtest parallel-random-engines: SKIP (0.000s)
[448.209991] [072/132] (576s left) perf_pmu (interrupts)
[448.250171] Starting subtest: interrupts
[449.338315] Subtest interrupts: SUCCESS (1.086s)
[449.466967] [073/132] (575s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[449.561107] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[449.565329] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[449.674343] [074/132] (575s left) kms_invalid_mode (bad-hsync-start)
[449.766982] Starting subtest: bad-hsync-start
[449.769349] Starting dynamic subtest: pipe-A-eDP-1
[450.053275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[450.063628] Starting dynamic subtest: pipe-B-eDP-1
[450.065664] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[450.074516] Starting dynamic subtest: pipe-C-eDP-1
[450.080432] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[450.096482] Starting dynamic subtest: pipe-D-eDP-1
[450.098884] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[450.101315] Subtest bad-hsync-start: SUCCESS (0.290s)
[450.917036] [075/132] (574s left) kms_flip (2x-flip-vs-dpms)
[451.020016] Starting subtest: 2x-flip-vs-dpms
[451.028093] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[451.133939] [076/132] (574s left) i915_pm_rpm (gem-mmap-type)
[453.357037] Starting subtest: gem-mmap-type
[453.360180] Starting dynamic subtest: wb-smem0
[457.158509] Dynamic subtest wb-smem0: SUCCESS (3.800s)
[457.169005] Starting dynamic subtest: wc-smem0
[460.629376] Dynamic subtest wc-smem0: SUCCESS (3.469s)
[460.643177] Starting dynamic subtest: uc-smem0
[463.795262] Dynamic subtest uc-smem0: SUCCESS (3.162s)
[463.797511] Subtest gem-mmap-type: SUCCESS (10.435s)
[463.880218] [077/132] (561s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[463.984813] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[470.834764] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.852s)
[470.982240] [078/132] (554s left) kms_psr (fbc-pr-cursor-plane-onoff)
[471.077735] Starting subtest: fbc-pr-cursor-plane-onoff
[471.081994] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[471.164253] [079/132] (554s left) gem_mmap_gtt (coherency)
[471.214829] Subtest coherency: SKIP (0.000s)
[471.276382] [080/132] (554s left) gem_ctx_sseu (invalid-args)
[471.333713] Subtest invalid-args: SKIP (0.000s)
[471.393887] [081/132] (554s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[471.483070] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[472.095837] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.614s)
[472.257164] [082/132] (553s left) kms_content_protection (suspend-resume)
[472.405260] Starting subtest: suspend-resume
[472.409700] Subtest suspend-resume: SKIP (0.000s)
[472.531275] [083/132] (552s left) prime_mmap_coherency (write)
[472.576595] Starting subtest: write
[477.952172] Subtest write: SUCCESS (5.376s)
[478.089332] [084/132] (547s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[478.178869] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[478.181208] Starting dynamic subtest: A-eDP1
[487.047076] Dynamic subtest A-eDP1: SUCCESS (8.869s)
[487.058231] Starting dynamic subtest: B-eDP1
[495.933864] Dynamic subtest B-eDP1: SUCCESS (8.885s)
[495.944963] Starting dynamic subtest: C-eDP1
[504.822756] Dynamic subtest C-eDP1: SUCCESS (8.887s)
[504.835094] Starting dynamic subtest: D-eDP1
[513.720578] Dynamic subtest D-eDP1: SUCCESS (8.894s)
[513.725801] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.547s)
[514.915407] [085/132] (510s left) gen9_exec_parse (unaligned-access)
[514.983947] Subtest unaligned-access: SKIP (0.000s)
[515.052098] [086/132] (510s left) gem_request_retire (retire-vma-not-inactive)
[515.109164] Starting subtest: retire-vma-not-inactive
[515.170356] Subtest retire-vma-not-inactive: SUCCESS (0.059s)
[515.290484] [087/132] (510s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[515.381981] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[519.054250] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.675s)
[520.253491] [088/132] (505s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[520.346851] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[527.313470] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.969s)
[527.441625] [089/132] (498s left) gem_softpin (softpin)
[527.511492] Starting subtest: softpin
[559.848957] Subtest softpin: SUCCESS (32.325s)
[559.968945] [090/132] (465s left) syncobj_timeline (multi-wait-available-signaled)
[560.025847] Starting subtest: multi-wait-available-signaled
[560.028118] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[560.128329] [091/132] (465s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[560.218288] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[567.400073] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.182s)
[567.536651] [092/132] (458s left) kms_psr (fbc-psr2-no-drrs)
[567.625762] Starting subtest: fbc-psr2-no-drrs
[567.627948] Starting dynamic subtest: eDP-1
[567.631940] Dynamic subtest eDP-1: SKIP (0.000s)
[567.635811] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[567.714620] [093/132] (458s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[568.268268] Starting subtest: syncobj-timeline-invalid-flags
[568.271010] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[569.215732] [094/132] (456s left) gem_pread (bench)
[569.288305] Subtest bench: SKIP (0.000s)
[569.358388] [095/132] (456s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[569.456118] Starting subtest: fbcpsr-rgb565-draw-render
[576.469012] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.010s)
[576.618584] [096/132] (449s left) kms_plane_alpha_blend (coverage-7efc)
[576.722718] Starting subtest: coverage-7efc
[577.011045] Starting dynamic subtest: pipe-A-eDP-1
[577.578631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[577.606282] Starting dynamic subtest: pipe-D-eDP-1
[578.917250] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s)
[578.919476] Subtest coverage-7efc: SUCCESS (2.194s)
[579.720040] [097/132] (446s left) perf_pmu (idle)
[579.761484] Starting subtest: idle
[579.763864] Starting dynamic subtest: rcs0
[580.313871] Dynamic subtest rcs0: SUCCESS (0.550s)
[580.326056] Starting dynamic subtest: bcs0
[580.835321] Dynamic subtest bcs0: SUCCESS (0.518s)
[580.847463] Starting dynamic subtest: vcs0
[581.356109] Dynamic subtest vcs0: SUCCESS (0.518s)
[581.368578] Starting dynamic subtest: vcs1
[581.885169] Dynamic subtest vcs1: SUCCESS (0.522s)
[581.896746] Starting dynamic subtest: vecs0
[582.411640] Dynamic subtest vecs0: SUCCESS (0.528s)
[582.424030] Starting dynamic subtest: ccs0
[582.936713] Dynamic subtest ccs0: SUCCESS (0.517s)
[582.939353] Subtest idle: SUCCESS (3.169s)
[583.054461] [098/132] (443s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[583.169371] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[587.258391] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.091s)
[588.447458] [099/132] (437s left) gem_exec_reloc (basic-cpu-read-noreloc)
[588.519450] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[588.593894] [100/132] (437s left) kms_flip (dpms-vs-vblank-race-interruptible)
[588.695949] Starting subtest: dpms-vs-vblank-race-interruptible
[588.698279] Starting dynamic subtest: A-eDP1
[592.592169] Dynamic subtest A-eDP1: SUCCESS (3.891s)
[592.601614] Starting dynamic subtest: B-eDP1
[596.093146] Dynamic subtest B-eDP1: SUCCESS (3.500s)
[596.108089] Starting dynamic subtest: C-eDP1
[599.592659] Dynamic subtest C-eDP1: SUCCESS (3.497s)
[599.605342] Starting dynamic subtest: D-eDP1
[603.087888] Dynamic subtest D-eDP1: SUCCESS (3.495s)
[603.090295] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (14.393s)
[603.929526] [101/132] (422s left) vgem_basic (debugfs)
[603.982184] Starting subtest: debugfs
[603.984358] Subtest debugfs: SUCCESS (0.000s)
[604.050347] [102/132] (422s left) perf_pmu (invalid-init)
[604.093512] Starting subtest: invalid-init
[604.095357] Subtest invalid-init: SUCCESS (0.000s)
[604.200917] [103/132] (422s left) kms_cursor_edge_walk (128x128-top-edge)
[604.288759] Starting subtest: 128x128-top-edge
[604.291025] Starting dynamic subtest: pipe-A-eDP-1
[607.750595] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[607.760524] Starting dynamic subtest: pipe-D-eDP-1
[610.951185] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.200s)
[610.953414] Subtest 128x128-top-edge: SUCCESS (6.665s)
[611.818123] [104/132] (414s left) gem_mmap_gtt (cpuset-big-copy)
[611.871509] Subtest cpuset-big-copy: SKIP (0.000s)
[611.936861] [105/132] (414s left) gem_userptr_blits (nohangcheck)
[612.013291] Starting subtest: nohangcheck
[612.273631] Subtest nohangcheck: SUCCESS (0.256s)
[612.397627] [106/132] (414s left) gem_ctx_persistence (idempotent)
[612.460050] Starting subtest: idempotent
[612.462339] Subtest idempotent: SUCCESS (0.000s)
[612.567827] [107/132] (413s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[612.659395] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[612.664027] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[612.747082] [108/132] (413s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[612.844908] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[612.847153] Starting dynamic subtest: pipe-A-eDP-1
[612.855843] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[612.866610] Starting dynamic subtest: pipe-B-eDP-1
[612.875106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[612.884641] Starting dynamic subtest: pipe-C-eDP-1
[612.892798] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[612.901454] Starting dynamic subtest: pipe-D-eDP-1
[612.909541] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[612.913474] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[615.118888] [109/132] (411s left) gem_exec_balancer (fairslice)
[615.181207] Starting subtest: fairslice
[618.085755] Subtest fairslice: SUCCESS (2.903s)
[619.202370] [110/132] (407s left) kms_vblank (ts-continuation-dpms-suspend)
[619.306277] Starting subtest: ts-continuation-dpms-suspend
[619.308660] Starting dynamic subtest: pipe-A-eDP-1
[635.772591] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[635.791634] Starting dynamic subtest: pipe-D-eDP-1
[653.901655] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.706s)
[653.904342] Subtest ts-continuation-dpms-suspend: SUCCESS (4.606s)
[654.579926] [111/132] (372s left) gem_sync (basic-many-each)
[654.671890] Starting subtest: basic-many-each
[656.978973] Subtest basic-many-each: SUCCESS (2.288s)
[657.164883] [112/132] (369s left) gem_madvise (dontneed-before-mmap)
[657.207077] Starting subtest: dontneed-before-mmap
[657.223433] Subtest dontneed-before-mmap: SUCCESS (0.016s)
[657.328964] [113/132] (369s left) sw_sync (timeline_closed_signaled)
[657.369952] Starting subtest: timeline_closed_signaled
[657.372034] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[657.430812] [114/132] (369s left) syncobj_timeline (etime-single-wait-submitted)
[657.480722] Starting subtest: etime-single-wait-submitted
[657.582609] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[657.682815] [115/132] (369s left) gem_mmap_gtt (basic)
[657.734046] Subtest basic: SKIP (0.000s)
[657.790383] [116/132] (369s left) core_setmaster_vs_auth
[657.940450] [117/132] (368s left) kms_flip (flip-vs-rmfb)
[658.036550] Starting subtest: flip-vs-rmfb
[658.038106] Starting dynamic subtest: A-eDP1
[666.700911] Dynamic subtest A-eDP1: SUCCESS (8.611s)
[666.711703] Starting dynamic subtest: B-eDP1
[675.351504] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[675.361187] Starting dynamic subtest: C-eDP1
[684.057679] Dynamic subtest C-eDP1: SUCCESS (8.696s)
[684.067585] Starting dynamic subtest: D-eDP1
[692.778930] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[692.783801] Subtest flip-vs-rmfb: SUCCESS (34.665s)
[694.003715] [118/132] (332s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[694.158244] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[701.489882] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.337s)
[701.629820] [119/132] (325s left) gem_exec_whisper (basic-contexts-priority-all)
[701.689722] Starting subtest: basic-contexts-priority-all
[725.985250] Subtest basic-contexts-priority-all: SUCCESS (24.289s)
[726.171022] [120/132] (300s left) gen9_exec_parse (allowed-single)
[726.243185] Subtest allowed-single: SKIP (0.000s)
[726.308949] [121/132] (300s left) dmabuf_sync_file (export-before-signal)
[726.350800] Starting subtest: export-before-signal
[726.352851] Subtest export-before-signal: SUCCESS (0.001s)
[726.410245] [122/132] (300s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[726.799960] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[727.587532] [123/132] (299s left) gem_ctx_param (invalid-get-no-zeromap)
[727.634009] Starting subtest: invalid-get-no-zeromap
[727.636948] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[727.741322] [124/132] (299s left) kms_legacy_colorkey (basic)
[727.838947] Starting subtest: basic
[727.841303] Starting dynamic subtest: pipe-A
[727.882145] Dynamic subtest pipe-A: SUCCESS (0.045s)
[727.894434] Starting dynamic subtest: pipe-B
[727.896844] Dynamic subtest pipe-B: SUCCESS (0.001s)
[727.907041] Starting dynamic subtest: pipe-C
[727.909411] Dynamic subtest pipe-C: SUCCESS (0.001s)
[727.919139] Starting dynamic subtest: pipe-D
[727.921922] Dynamic subtest pipe-D: SUCCESS (0.000s)
[727.924331] Subtest basic: SUCCESS (0.052s)
[727.963492] [125/132] (299s left) gem_eio (unwedge-stress)
[728.167440] Starting subtest: unwedge-stress
[728.170166] Starting dynamic subtest: render
[732.689268] Dynamic subtest render: SUCCESS (4.519s)
[732.704626] Starting dynamic subtest: bsd1
[750.524329] Dynamic subtest bsd1: SUCCESS (17.828s)
[750.540428] Starting dynamic subtest: bsd2
[768.597260] Dynamic subtest bsd2: SUCCESS (18.076s)
[768.614814] Starting dynamic subtest: blt
[768.619648] Dynamic subtest blt: SKIP (0.000s)
[768.629930] Starting dynamic subtest: vebox
[786.532819] Dynamic subtest vebox: SUCCESS (17.934s)
[786.535107] Subtest unwedge-stress: SUCCESS (58.361s)
[788.107984] [126/132] (239s left) kms_addfb_basic (unused-handle)
[788.160065] Starting subtest: unused-handle
[788.162545] Subtest unused-handle: SUCCESS (0.000s)
[788.306639] [127/132] (239s left) gem_softpin (allocator-evict)
[788.369315] Starting subtest: allocator-evict
[788.372275] Starting dynamic subtest: rcs0
[812.140273] Dynamic subtest rcs0: SUCCESS (23.767s)
[812.156416] Starting dynamic subtest: bcs0
[836.442917] Dynamic subtest bcs0: SUCCESS (24.296s)
[836.454174] Starting dynamic subtest: vcs0
[859.942883] Dynamic subtest vcs0: SUCCESS (23.493s)
[859.954317] Starting dynamic subtest: vcs1
[883.610184] Dynamic subtest vcs1: SUCCESS (23.662s)
[883.622369] Starting dynamic subtest: vecs0
[907.121233] Dynamic subtest vecs0: SUCCESS (23.515s)
[907.132983] Starting dynamic subtest: ccs0
[931.278078] Dynamic subtest ccs0: SUCCESS (24.157s)
[931.280945] Subtest allocator-evict: SUCCESS (142.897s)
[931.360730] [128/132] ( 96s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[931.499148] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[931.501992] Starting dynamic subtest: pipe-A
[931.561598] Dynamic subtest pipe-A: SUCCESS (0.064s)
[931.574325] Starting dynamic subtest: pipe-B
[932.682401] Dynamic subtest pipe-B: SUCCESS (1.120s)
[932.694756] Starting dynamic subtest: pipe-C
[933.855431] Dynamic subtest pipe-C: SUCCESS (1.171s)
[933.866394] Starting dynamic subtest: pipe-D
[934.956749] Dynamic subtest pipe-D: SUCCESS (1.101s)
[934.959402] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.461s)
[936.098770] [129/132] ( 91s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[936.500210] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[937.270877] [130/132] ( 90s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[937.367021] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[937.372074] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[937.448215] [131/132] ( 90s left) kms_properties (colorop-properties-atomic)
[937.539821] Starting subtest: colorop-properties-atomic
[937.542409] Starting dynamic subtest: pipe-A-eDP-1
[937.915361] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s)
[937.927368] Starting dynamic subtest: pipe-B-eDP-1
[939.009374] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.093s)
[939.027286] Starting dynamic subtest: pipe-C-eDP-1
[940.107410] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.096s)
[940.118116] Starting dynamic subtest: pipe-D-eDP-1
[941.242601] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[941.244905] Subtest colorop-properties-atomic: SUCCESS (3.704s)
[942.087119] [132/132] ( 85s left) sysfs_timeslice_duration (invalid)
[942.149287] Starting subtest: invalid
[942.151978] Starting dynamic subtest: vecs0
[942.154235] Dynamic subtest vecs0: SUCCESS (0.000s)
[942.164847] Starting dynamic subtest: ccs0
[942.167123] Dynamic subtest ccs0: SUCCESS (0.000s)
[942.177038] Starting dynamic subtest: vcs0
[942.179351] Dynamic subtest vcs0: SUCCESS (0.000s)
[942.189153] Starting dynamic subtest: bcs0
[942.191282] Dynamic subtest bcs0: SUCCESS (0.000s)
[942.201172] Starting dynamic subtest: rcs0
[942.203565] Dynamic subtest rcs0: SUCCESS (0.000s)
[942.213290] Starting dynamic subtest: vcs1
[942.215847] Dynamic subtest vcs1: SUCCESS (0.000s)
[942.218148] Subtest invalid: SUCCESS (0.006s)
[942.254790] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_atomic
results: parsing output: 11/ for test: drm_read
results: parsing output: 12/ for test: gem_pxp
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: kms_hdmi_inject
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: api_intel_bb
results: parsing output: 21/ for test: kms_async_flips
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_color_pipeline
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: sw_sync
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: api_intel_allocator
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: gem_ctx_exec
results: parsing output: 35/ for test: kms_setmode
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_linear_blits
results: parsing output: 38/ for test: kms_pm_backlight
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_plane_lowres
results: parsing output: 44/ for test: i915_suspend
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: prime_self_import
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: sw_sync
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: gem_busy
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: kms_sequence
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_mmap_offset
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_exec_capture
results: parsing output: 66/ for test: kms_draw_crc
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_invalid_mode
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: i915_pm_rpm
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: gem_ctx_sseu
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_content_protection
results: parsing output: 82/ for test: prime_mmap_coherency
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: gem_request_retire
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: gem_pread
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_plane_alpha_blend
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: vgem_basic
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: kms_cursor_edge_walk
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_ctx_persistence
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: gem_sync
results: parsing output: 111/ for test: gem_madvise
results: parsing output: 112/ for test: sw_sync
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: core_setmaster_vs_auth
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_whisper
results: parsing output: 119/ for test: gen9_exec_parse
results: parsing output: 120/ for test: dmabuf_sync_file
results: parsing output: 121/ for test: kms_chamelium_edid
results: parsing output: 122/ for test: gem_ctx_param
results: parsing output: 123/ for test: kms_legacy_colorkey
results: parsing output: 124/ for test: gem_eio
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_chamelium_hpd
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_properties
results: parsing output: 131/ for test: sysfs_timeslice_duration
Done.