[58.443120] Initializing watchdogs
[58.443206]   /dev/watchdog0
[58.458027] [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.462549] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.464714] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.466589] [001/133] (960s left) api_intel_allocator (gem-pool)
[58.531625] Starting subtest: gem-pool
[58.542044] Subtest gem-pool: SUCCESS (0.012s)
[58.645310] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[58.737988] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[58.739781] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[58.848192] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[58.931956] Starting subtest: read-crc-frame-sequence
[58.932864] Starting dynamic subtest: pipe-A-eDP-1
[59.647260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[59.653181] Starting dynamic subtest: pipe-B-eDP-1
[61.005218] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.357s)
[61.011618] Starting dynamic subtest: pipe-C-eDP-1
[62.313361] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.308s)
[62.319050] Starting dynamic subtest: pipe-D-eDP-1
[63.640674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[63.641650] Subtest read-crc-frame-sequence: SUCCESS (4.709s)
[64.479341] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[64.537606] Starting subtest: invalid-query-one-illegal-handle
[64.538584] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[64.632552] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[64.678044] Starting subtest: invalid-signal-zero-handles
[64.678988] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[64.779187] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[64.875270] Starting subtest: fbcpsr-rgb565-draw-render
[72.339390] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.465s)
[72.491290] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[72.550408] Starting subtest: wait-for-submit-snapshot
[72.632521] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[72.709389] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[72.810636] Starting subtest: psr-rgb565-draw-blt
[79.896254] Subtest psr-rgb565-draw-blt: SUCCESS (7.086s)
[80.037682] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[80.192221] Starting subtest: cursor-onscreen-32x10
[80.235911] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[80.514702] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[80.562982] Starting subtest: invalid-signal-illegal-handle
[80.563974] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[80.685461] [011/133] (938s left) testdisplay
[81.011870] [012/133] (938s left) prime_mmap (test_map_unmap)
[81.060175] Starting subtest: test_map_unmap
[81.060990] Starting dynamic subtest: test_map_unmap-smem
[81.092629] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[81.093810] Subtest test_map_unmap: SUCCESS (0.033s)
[81.215203] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[81.780205] Starting subtest: syncobj-timeline-signal
[81.781588] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[83.012096] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[83.013685] [014/133] (936s left) syncobj_timeline (signal-point-0)
[83.069048] Starting subtest: signal-point-0
[83.070033] Subtest signal-point-0: SUCCESS (0.000s)
[83.186174] [015/133] (936s left) kms_psr (psr2-suspend)
[83.263342] Starting subtest: psr2-suspend
[83.264254] Starting dynamic subtest: eDP-1
[101.731404] Dynamic subtest eDP-1: SUCCESS (3.472s)
[101.732322] Subtest psr2-suspend: SUCCESS (3.472s)
[111.675490] [016/133] (916s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[111.776803] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[111.781908] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[111.849636] [017/133] (916s left) gem_softpin (reverse)
[111.921872] Starting subtest: reverse
[111.929328] Subtest reverse: SUCCESS (0.008s)
[112.066255] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[112.316978] Starting subtest: parallel-contexts
[114.909184] Subtest parallel-contexts: SUCCESS (2.593s)
[115.935258] [019/133] (912s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[116.034557] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[116.035417] Starting dynamic subtest: pipe-A-eDP-1
[118.174586] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.140s)
[118.182696] Starting dynamic subtest: pipe-B-eDP-1
[120.397163] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.221s)
[120.410765] Starting dynamic subtest: pipe-C-eDP-1
[122.465460] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.067s)
[122.473680] Starting dynamic subtest: pipe-D-eDP-1
[124.521395] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.055s)
[124.522461] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.488s)
[125.719176] [020/133] (902s left) kms_lease (lease-unleased-connector)
[125.822050] Starting subtest: lease-unleased-connector
[125.822911] Starting dynamic subtest: pipe-A-eDP-1
[125.832177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.009s)
[125.840461] Starting dynamic subtest: pipe-B-eDP-1
[125.842910] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[125.849899] Starting dynamic subtest: pipe-C-eDP-1
[125.852035] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[125.858877] Starting dynamic subtest: pipe-D-eDP-1
[125.859678] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[125.860498] Subtest lease-unleased-connector: SUCCESS (0.038s)
[125.998643] [021/133] (902s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[126.113173] Starting subtest: cursor-vs-flip-atomic-transitions
[156.122085] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.010s)
[156.949429] [022/133] (871s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[157.039871] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[157.040960] Starting dynamic subtest: pipe-A-default-mode
[159.810042] Dynamic subtest pipe-A-default-mode: SUCCESS (2.769s)
[159.810960] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.771s)
[160.646622] [023/133] (868s left) kms_addfb_basic (legacy-format)
[160.706524] Starting subtest: legacy-format
[160.725013] Subtest legacy-format: SUCCESS (0.018s)
[160.891314] [024/133] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[160.983521] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[160.985382] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[161.118236] [025/133] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[161.221496] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[161.223323] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[161.334112] [026/133] (867s left) kms_vblank (query-busy)
[161.422335] Starting subtest: query-busy
[161.423285] Starting dynamic subtest: pipe-A-eDP-1
[163.304072] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[163.313750] Starting dynamic subtest: pipe-D-eDP-1
[165.911703] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.605s)
[165.912692] Subtest query-busy: SUCCESS (4.491s)
[166.718028] [027/133] (862s left) gem_wait (invalid-flags)
[166.790278] Starting subtest: invalid-flags
[166.791320] Subtest invalid-flags: SUCCESS (0.000s)
[167.030710] [028/133] (861s left) kms_properties (invalid-properties-atomic)
[167.134148] Starting subtest: invalid-properties-atomic
[167.464996] Subtest invalid-properties-atomic: SUCCESS (0.321s)
[167.532622] [029/133] (861s left) gem_exec_flush (basic-wb-ro-before-default)
[167.590985] Starting subtest: basic-wb-ro-before-default
[173.041037] Subtest basic-wb-ro-before-default: SUCCESS (5.450s)
[173.230284] [030/133] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[173.340511] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[173.342230] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[173.469522] [031/133] (855s left) kms_psr (pr-primary-blt)
[173.566007] Starting subtest: pr-primary-blt
[173.567778] Subtest pr-primary-blt: SKIP (0.000s)
[173.644485] [032/133] (855s left) kms_flip (2x-flip-vs-dpms-on-nop)
[173.734508] Starting subtest: 2x-flip-vs-dpms-on-nop
[173.746137] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[173.875452] [033/133] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[173.968583] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[173.970452] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[174.063962] [034/133] (855s left) kms_chamelium_edid (dp-mode-timings)
[174.466352] Subtest dp-mode-timings: SKIP (0.000s)
[175.228639] [035/133] (853s left) kms_flip (flip-vs-panning-interruptible)
[175.320167] Starting subtest: flip-vs-panning-interruptible
[175.322601] Starting dynamic subtest: A-eDP1
[184.073435] Dynamic subtest A-eDP1: SUCCESS (8.751s)
[184.083679] Starting dynamic subtest: B-eDP1
[192.804597] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[192.814606] Starting dynamic subtest: C-eDP1
[201.535625] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[201.545336] Starting dynamic subtest: D-eDP1
[210.189111] Dynamic subtest D-eDP1: SUCCESS (8.648s)
[210.195298] Subtest flip-vs-panning-interruptible: SUCCESS (34.870s)
[211.450779] [036/133] (817s left) kms_pm_dc (dc5-psr)
[212.552233] Starting subtest: dc5-psr
[215.435217] Subtest dc5-psr: SUCCESS (2.883s)
[216.282497] [037/133] (812s left) gem_userptr_blits (process-exit)
[216.360242] Starting subtest: process-exit
[216.369254] Subtest process-exit: SUCCESS (0.009s)
[216.519963] [038/133] (812s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[216.611037] Starting subtest: plane-lut1d-post-ctm3x4
[216.625146] Starting dynamic subtest: pipe-A-eDP-1
[217.053401] Dynamic subtest pipe-A-eDP-1: FAIL (0.292s)
[217.946290] Starting dynamic subtest: pipe-B-eDP-1
[218.414556] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[219.272892] Starting dynamic subtest: pipe-C-eDP-1
[219.696530] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[220.602165] Starting dynamic subtest: pipe-D-eDP-1
[221.049913] Dynamic subtest pipe-D-eDP-1: FAIL (0.237s)
[221.131317] Subtest plane-lut1d-post-ctm3x4: FAIL (4.519s)
[221.991195] [039/133] (807s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[222.052474] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[222.157716] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[222.240790] [040/133] (807s left) gem_mmap_offset (partial-remap)
[222.298613] Starting subtest: partial-remap
[222.300898] Starting dynamic subtest: smem0
[222.307595] Dynamic subtest smem0: SUCCESS (0.006s)
[222.308512] Subtest partial-remap: SUCCESS (0.007s)
[222.453563] [041/133] (806s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[222.562024] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[222.563733] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[222.680472] [042/133] (806s left) gem_userptr_blits (dmabuf-unsync)
[222.750733] Subtest dmabuf-unsync: SKIP (0.000s)
[222.903376] [043/133] (806s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[223.014641] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[223.016293] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[223.115961] [044/133] (806s left) gem_close_race (multigpu-basic-threads)
[223.189224] Starting subtest: multigpu-basic-threads
[223.191175] Subtest multigpu-basic-threads: SKIP (0.000s)
[223.458002] [045/133] (806s left) gem_exec_schedule (preempt)
[223.516309] Starting subtest: preempt
[223.517412] Starting dynamic subtest: rcs0
[223.537920] Dynamic subtest rcs0: SUCCESS (0.021s)
[223.547969] Starting dynamic subtest: bcs0
[223.556195] Dynamic subtest bcs0: SUCCESS (0.018s)
[223.563594] Starting dynamic subtest: vcs0
[223.575145] Dynamic subtest vcs0: SUCCESS (0.018s)
[223.584277] Starting dynamic subtest: vcs1
[223.596345] Dynamic subtest vcs1: SUCCESS (0.020s)
[223.605252] Starting dynamic subtest: vecs0
[223.614324] Dynamic subtest vecs0: SUCCESS (0.017s)
[223.621624] Starting dynamic subtest: ccs0
[223.632721] Dynamic subtest ccs0: SUCCESS (0.018s)
[223.633654] Subtest preempt: SUCCESS (0.117s)
[224.976699] [046/133] (804s left) i915_module_load (reload)
[225.011292] Starting subtest: reload
[230.032000] Subtest reload: SUCCESS (5.021s)
[230.068155] [047/133] (799s left) gem_exec_reloc (basic-wc-cpu-active)
[231.831725] Subtest basic-wc-cpu-active: SKIP (0.000s)
[231.918839] [048/133] (797s left) gen9_exec_parse (valid-registers)
[231.985724] Subtest valid-registers: SKIP (0.000s)
[232.067317] [049/133] (797s left) kms_cursor_edge_walk (64x64-left-edge)
[232.160224] Starting subtest: 64x64-left-edge
[232.161065] Starting dynamic subtest: pipe-A-eDP-1
[235.657572] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[235.664131] Starting dynamic subtest: pipe-D-eDP-1
[238.787754] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[238.788618] Subtest 64x64-left-edge: SUCCESS (6.627s)
[239.589314] [050/133] (790s left) gem_render_copy_redux (flink)
[239.639825] Starting subtest: flink
[240.334549] Subtest flink: SUCCESS (0.695s)
[240.480820] [051/133] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[240.573173] Starting subtest: psr-2p-primscrn-spr-indfb-move
[240.574921] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[240.674934] [052/133] (789s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[240.764230] Starting subtest: bo-too-small-due-to-tiling
[240.765967] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[240.899435] [053/133] (788s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[240.997703] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[247.579761] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.581s)
[247.700311] [054/133] (782s left) gem_exec_reloc (basic-write-wc-active)
[247.763096] Subtest basic-write-wc-active: SKIP (0.000s)
[247.839026] [055/133] (781s left) gem_fenced_exec_thrash (2-spare-fences)
[247.887392] Subtest 2-spare-fences: SKIP (0.000s)
[247.950250] [056/133] (781s left) kms_hdr (static-toggle-dpms)
[248.037771] Starting subtest: static-toggle-dpms
[248.040298] Subtest static-toggle-dpms: SKIP (0.000s)
[248.117989] [057/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[248.196486] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[255.383966] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.188s)
[255.516912] [058/133] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[255.620436] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[259.420814] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.801s)
[260.585894] [059/133] (769s left) gem_lmem_swapping (parallel-random-verify)
[260.623349] Subtest parallel-random-verify: SKIP (0.000s)
[260.658403] [060/133] (769s left) kms_psr (fbc-pr-sprite-plane-move)
[260.745382] Starting subtest: fbc-pr-sprite-plane-move
[260.747367] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[260.825292] [061/133] (769s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[261.196417] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[261.962856] [062/133] (768s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[262.052415] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[262.060946] Starting dynamic subtest: pipe-A-eDP-1
[262.070359] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.078277] Starting dynamic subtest: pipe-B-eDP-1
[262.087420] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.094444] Starting dynamic subtest: pipe-C-eDP-1
[262.103353] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.109700] Starting dynamic subtest: pipe-D-eDP-1
[262.118973] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.120569] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[264.264753] [063/133] (765s left) i915_pm_rpm (gem-evict-pwrite)
[266.083470] Starting subtest: gem-evict-pwrite
[266.086247] Subtest gem-evict-pwrite: SKIP (0.000s)
[266.507189] [064/133] (763s left) gem_exec_whisper (basic-sync)
[266.566889] Starting subtest: basic-sync
[273.394455] Subtest basic-sync: SUCCESS (6.813s)
[273.571218] [065/133] (756s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[273.684658] Starting subtest: short-busy-flip-before-cursor-toggle
[273.687109] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[273.832440] [066/133] (756s left) i915_query (hwconfig_table)
[273.893875] Starting subtest: hwconfig_table
[273.999039] Subtest hwconfig_table: SUCCESS (0.001s)
[274.037369] [067/133] (756s left) kms_vrr (flipline)
[274.123157] Starting subtest: flipline
[274.125693] Subtest flipline: SKIP (0.000s)
[274.205097] [068/133] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[274.297516] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[278.642606] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.345s)
[279.793106] [069/133] (750s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[279.901478] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[279.906893] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[279.980002] [070/133] (750s left) kms_prop_blob (invalid-set-prop)
[280.041056] Starting subtest: invalid-set-prop
[280.042094] Subtest invalid-set-prop: SUCCESS (0.000s)
[280.174765] [071/133] (750s left) kms_properties (crtc-properties-legacy)
[280.269431] Starting subtest: crtc-properties-legacy
[280.271572] Starting dynamic subtest: pipe-A-eDP-1
[280.721275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[280.728826] Starting dynamic subtest: pipe-B-eDP-1
[281.846955] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.124s)
[281.855912] Starting dynamic subtest: pipe-C-eDP-1
[282.976146] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[282.983647] Starting dynamic subtest: pipe-D-eDP-1
[284.101195] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[284.102066] Subtest crtc-properties-legacy: SUCCESS (3.831s)
[284.935710] [072/133] (745s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[285.042789] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[291.978327] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.935s)
[292.136694] [073/133] (738s left) kms_psr (fbc-pr-cursor-render)
[292.228975] Starting subtest: fbc-pr-cursor-render
[292.230633] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[292.307938] [074/133] (738s left) gem_userptr_blits (huge-split)
[292.382240] Starting subtest: huge-split
[292.389640] Subtest huge-split: SUCCESS (0.007s)
[292.516908] [075/133] (737s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[292.748515] Starting subtest: cursor-rapid-movement-256x85
[292.792408] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[292.999545] [076/133] (737s left) gem_unref_active_buffers
[293.190720] [077/133] (737s left) gem_caching (reads)
[293.249832] Subtest reads: SKIP (0.000s)
[293.320533] [078/133] (737s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[293.371054] Starting subtest: invalid-multi-wait-all-unsubmitted
[293.371932] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[293.472759] [079/133] (737s left) gem_exec_create (basic)
[293.527288] Starting subtest: basic
[293.528375] Starting dynamic subtest: smem
[295.620102] Dynamic subtest smem: SUCCESS (2.092s)
[295.622322] Subtest basic: SUCCESS (2.095s)
[295.811866] [080/133] (734s left) kms_content_protection (atomic-dpms-hdcp14)
[295.962269] Starting subtest: atomic-dpms-hdcp14
[295.964104] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[296.109297] [081/133] (734s left) sw_sync (timeline_closed)
[296.140509] Starting subtest: timeline_closed
[296.141392] Subtest timeline_closed: SUCCESS (0.000s)
[296.194327] [082/133] (734s left) perf (oa-exponents)
[296.314438] Starting subtest: oa-exponents
[296.315365] Starting dynamic subtest: 0-rcs0
[298.097393] Dynamic subtest 0-rcs0: SUCCESS (1.771s)
[298.106719] Starting dynamic subtest: 1-vecs0
[299.900356] Dynamic subtest 1-vecs0: SUCCESS (1.804s)
[299.901591] Subtest oa-exponents: SUCCESS (3.576s)
[299.934297] [083/133] (730s left) kms_feature_discovery (display-2x)
[300.031393] Starting subtest: display-2x
[300.033183] Subtest display-2x: SKIP (0.000s)
[300.112180] [084/133] (730s left) core_setmaster (master-drop-set-root)
[300.200198] Starting subtest: master-drop-set-root
[300.211650] Subtest master-drop-set-root: SUCCESS (0.011s)
[300.253956] [085/133] (730s left) kms_pm_rpm (i2c)
[302.066354] Starting subtest: i2c
[307.125881] Subtest i2c: SUCCESS (5.059s)
[307.238606] [086/133] (723s left) kms_busy (basic-hang)
[307.332079] Starting subtest: basic-hang
[307.333039] Starting dynamic subtest: flip-pipe-A
[307.922401] Dynamic subtest flip-pipe-A: SUCCESS (0.589s)
[307.930316] Starting dynamic subtest: modeset-pipe-A
[311.311405] Dynamic subtest modeset-pipe-A: SUCCESS (3.387s)
[311.320317] Starting dynamic subtest: flip-pipe-D
[312.506141] Dynamic subtest flip-pipe-D: SUCCESS (1.192s)
[312.513910] Starting dynamic subtest: modeset-pipe-D
[315.950589] Dynamic subtest modeset-pipe-D: SUCCESS (3.444s)
[315.952600] Subtest basic-hang: SUCCESS (8.620s)
[316.752265] [087/133] (714s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[316.842183] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[316.843915] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[316.965443] [088/133] (713s left) kms_flip (nonblocking-read)
[317.066614] Starting subtest: nonblocking-read
[317.067631] Subtest nonblocking-read: SUCCESS (0.000s)
[317.188013] [089/133] (713s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[317.284199] Starting subtest: yf-tiled-16bpp-rotate-270
[317.286173] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[317.387252] [090/133] (713s left) gem_mmap_wc (write-read-distinct)
[317.445888] Subtest write-read-distinct: SKIP (0.000s)
[317.516898] [091/133] (713s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[317.577743] Starting subtest: multi-wait-for-submit-submitted-signaled
[317.578719] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[317.676080] [092/133] (713s left) kms_flip (blocking-wf_vblank)
[317.774076] Starting subtest: blocking-wf_vblank
[317.776202] Starting dynamic subtest: A-eDP1
[326.691250] Dynamic subtest A-eDP1: SUCCESS (8.916s)
[326.702165] Starting dynamic subtest: B-eDP1
[335.640690] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[335.650251] Starting dynamic subtest: C-eDP1
[344.570581] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[344.584706] Starting dynamic subtest: D-eDP1
[353.496419] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[353.497350] Subtest blocking-wf_vblank: SUCCESS (35.689s)
[354.696731] [093/133] (676s left) gem_exec_alignment (pi)
[354.763547] Starting subtest: pi
[406.468822] Subtest pi: SUCCESS (51.700s)
[407.689821] [094/133] (623s left) kms_getfb (getfb-repeated-different-handles)
[407.835188] Starting subtest: getfb-repeated-different-handles
[407.836220] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[407.972219] [095/133] (623s left) syncobj_timeline (etime-multi-wait-submitted)
[408.038773] Starting subtest: etime-multi-wait-submitted
[408.141162] Subtest etime-multi-wait-submitted: SUCCESS (0.105s)
[408.228619] [096/133] (622s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[408.346315] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[409.330042] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.983s)
[410.149737] [097/133] (621s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[410.238077] Starting subtest: primary-yf-tiled-reflect-x-0
[410.300634] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.061s)
[410.408551] [098/133] (620s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[410.459709] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[410.530080] [099/133] (620s left) perf_pmu (rc6)
[410.567356] Starting subtest: rc6
[410.568298] Starting dynamic subtest: gt0
[416.996272] Dynamic subtest gt0: SUCCESS (6.381s)
[417.006961] Starting dynamic subtest: runtime-pm-gt0
[424.738049] Dynamic subtest runtime-pm-gt0: SUCCESS (7.775s)
[424.749096] Starting dynamic subtest: runtime-pm-long-gt0
[437.185403] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.445s)
[437.196164] Starting dynamic subtest: other-idle-gt0
[443.528907] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[443.539758] Starting dynamic subtest: gt1
[449.870545] Dynamic subtest gt1: SUCCESS (6.339s)
[449.879093] Starting dynamic subtest: runtime-pm-gt1
[457.306677] Dynamic subtest runtime-pm-gt1: SUCCESS (7.433s)
[457.317462] Starting dynamic subtest: runtime-pm-long-gt1
[469.796111] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.489s)
[469.807115] Starting dynamic subtest: other-idle-gt1
[476.138507] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[476.139698] Subtest rc6: SUCCESS (65.561s)
[476.736750] [100/133] (554s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[476.847426] Starting subtest: y-tiled-16bpp-rotate-0
[476.849175] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[476.925603] [101/133] (554s left) kms_flip_tiling (flip-change-tiling)
[477.014212] Starting subtest: flip-change-tiling
[477.015571] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[477.193940] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.180s)
[477.206622] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[477.347632] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[477.358319] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[477.471871] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[477.484926] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[477.616204] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[477.629257] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[477.760089] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[477.772106] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[477.904585] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[477.916536] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[478.038016] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[478.049803] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[478.149782] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[478.160875] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[478.295160] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[478.306897] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[478.454641] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.168s)
[478.467742] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[478.598752] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[478.610831] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[478.743237] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[478.755953] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[478.877176] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[478.889703] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[479.010699] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[479.022367] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[479.121476] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[479.132046] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[479.265891] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[479.282321] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[479.410597] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.141s)
[479.427132] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[479.554457] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[479.566724] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[479.699439] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[479.713048] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[479.843739] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[479.857472] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[479.988220] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[480.001494] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[480.110533] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[480.122188] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[480.254278] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[480.271630] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[480.398887] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[480.411092] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[480.543228] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[480.555350] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[480.688133] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[480.700612] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[480.832385] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[480.846339] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[480.977099] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[480.989284] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[481.099453] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[481.112349] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[481.243873] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[481.261824] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[481.387726] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[481.402447] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[481.532133] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.143s)
[481.544069] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[481.677724] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[481.688586] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[481.821238] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[481.834233] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[481.966041] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[481.978689] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[482.088302] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[482.147318] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[483.350781] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.216s)
[483.363706] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[483.495916] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[483.505904] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[483.617573] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[483.630347] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[483.761563] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[483.773883] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[483.906270] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[483.922906] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[484.050342] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[484.064481] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[484.195346] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.140s)
[484.207968] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[484.306390] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[484.319293] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[484.439841] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[484.452524] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[484.583842] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[484.594957] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[484.728387] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[484.740920] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[484.872591] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[484.884476] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[485.017597] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s)
[485.029749] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[485.164908] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[485.175619] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[485.273154] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[485.288703] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[485.417617] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[485.434134] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[485.561806] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[485.579378] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[485.706174] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[485.718928] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[485.850630] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[485.862483] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[485.995291] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[486.007189] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[486.139669] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[486.152296] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[486.261829] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[486.274639] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[486.406151] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[486.418224] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[486.550312] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[486.562270] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[486.694779] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[486.706417] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[486.839658] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[486.851417] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[486.983816] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[486.994702] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[487.128453] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[487.140773] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[487.278362] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.147s)
[487.290285] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[487.422922] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[487.436237] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[487.566838] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[487.579133] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[487.711214] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[487.723550] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[487.855964] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[487.867424] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[488.000466] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[488.013096] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[488.156664] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.153s)
[488.169177] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[488.278197] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.119s)
[488.330822] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[489.589413] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.265s)
[489.602607] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[489.689167] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.097s)
[489.700828] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[489.789077] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[489.801310] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[489.900374] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[489.913141] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[490.010829] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[490.022751] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[490.122222] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[490.133722] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[490.222651] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[490.235260] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[490.322611] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[490.333820] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[490.423159] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[490.436757] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[490.533504] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.108s)
[490.546073] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[490.644362] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[490.655142] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[490.755392] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[490.767606] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[490.855705] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[490.869507] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[490.955842] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[490.970584] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[491.055784] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[491.068444] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[491.166903] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[491.179429] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[491.277632] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[491.289759] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[491.388791] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[491.400566] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[491.500429] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[491.513755] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[491.611573] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[491.623943] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[491.722326] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[491.734185] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[491.833612] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[491.846181] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[491.983153] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.148s)
[491.995372] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[492.094008] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[492.108373] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[492.205177] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[492.217199] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[492.305072] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[492.317028] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[492.416318] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[492.428199] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[492.527341] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[492.539535] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[492.639158] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[492.650587] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[492.749840] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[492.762310] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[492.860761] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[492.872681] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[492.971991] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[492.983270] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[493.083050] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[493.094735] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[493.193977] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[493.204654] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[493.305614] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[493.317943] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[493.416667] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[493.458221] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[494.716305] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.265s)
[494.729324] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[494.815888] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[494.828377] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[494.915786] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[494.928708] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[495.027339] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[495.040342] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[495.148861] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.120s)
[495.160940] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[495.260207] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[495.272199] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[495.360485] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[495.373145] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[495.460807] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[495.474032] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[495.560371] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[495.572453] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[495.671630] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[495.684708] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[495.782077] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[495.793953] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[495.932025] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.149s)
[495.944715] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[496.032489] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[496.044245] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[496.132482] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[496.145869] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[496.232640] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[496.244321] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[496.343495] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[496.354918] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[496.454154] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[496.466103] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[496.565193] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[496.579938] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[496.676840] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[496.689535] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[496.788091] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[496.800304] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[496.899243] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[496.911773] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[497.009922] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[497.022181] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[497.121097] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[497.133970] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[497.231981] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[497.246574] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[497.343062] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[497.354338] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[497.454410] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[497.467943] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[497.565389] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[497.576413] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[497.676458] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[497.688122] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[497.787633] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[497.799831] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[497.899061] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[497.911561] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[498.009762] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[498.021744] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[498.120958] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[498.133679] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[498.243186] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.120s)
[498.254459] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[498.365328] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.120s)
[498.377191] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[498.487859] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.121s)
[498.500177] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[498.599014] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[498.632261] Subtest flip-change-tiling: SUCCESS (21.618s)
[499.785076] [102/133] (531s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[499.889204] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[499.890881] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[499.970604] [103/133] (531s left) gem_exec_fence (submit-chain)
[500.153658] Starting subtest: submit-chain
[500.170117] Subtest submit-chain: SUCCESS (0.019s)
[502.019722] [104/133] (529s left) gem_ringfill (engines-basic)
[507.892543] Starting subtest: engines-basic
[507.893842] Starting dynamic subtest: rcs0
[507.970666] Dynamic subtest rcs0: SUCCESS (0.084s)
[507.983772] Starting dynamic subtest: bcs0
[508.016414] Dynamic subtest bcs0: SUCCESS (0.044s)
[508.026808] Starting dynamic subtest: vcs0
[508.059499] Dynamic subtest vcs0: SUCCESS (0.041s)
[508.069479] Starting dynamic subtest: vcs1
[508.101516] Dynamic subtest vcs1: SUCCESS (0.040s)
[508.111542] Starting dynamic subtest: vecs0
[508.144549] Dynamic subtest vecs0: SUCCESS (0.041s)
[508.154771] Starting dynamic subtest: ccs0
[508.189260] Dynamic subtest ccs0: SUCCESS (0.043s)
[508.191798] Subtest engines-basic: SUCCESS (0.306s)
[508.240126] [105/133] (523s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[508.335081] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[508.335936] Starting dynamic subtest: pipe-A-eDP-1
[508.343619] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[508.356954] Starting dynamic subtest: pipe-B-eDP-1
[508.364703] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[508.374024] Starting dynamic subtest: pipe-C-eDP-1
[508.381508] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[508.389429] Starting dynamic subtest: pipe-D-eDP-1
[508.396643] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[508.397454] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[510.543243] [106/133] (520s left) perf_pmu (busy-check-all)
[510.584164] Starting subtest: busy-check-all
[510.585590] Starting dynamic subtest: rcs0
[511.136015] Dynamic subtest rcs0: SUCCESS (0.551s)
[511.147338] Starting dynamic subtest: bcs0
[511.685779] Dynamic subtest bcs0: SUCCESS (0.548s)
[511.697825] Starting dynamic subtest: vcs0
[512.882059] Dynamic subtest vcs0: SUCCESS (1.185s)
[512.892835] Starting dynamic subtest: vcs1
[514.929939] Dynamic subtest vcs1: SUCCESS (2.045s)
[514.939836] Starting dynamic subtest: vecs0
[516.913603] Dynamic subtest vecs0: SUCCESS (1.981s)
[516.923496] Starting dynamic subtest: ccs0
[517.458741] Dynamic subtest ccs0: SUCCESS (0.552s)
[517.461832] Subtest busy-check-all: SUCCESS (6.876s)
[517.516155] [107/133] (514s left) gem_exec_schedule (submit-early-slice)
[517.577481] Starting subtest: submit-early-slice
[517.578690] Starting dynamic subtest: rcs0
[517.633811] Dynamic subtest rcs0: SUCCESS (0.056s)
[517.646263] Starting dynamic subtest: bcs0
[517.690372] Dynamic subtest bcs0: SUCCESS (0.056s)
[517.702969] Starting dynamic subtest: vcs0
[517.738550] Dynamic subtest vcs0: SUCCESS (0.048s)
[517.748779] Starting dynamic subtest: vcs1
[517.789615] Dynamic subtest vcs1: SUCCESS (0.050s)
[517.800316] Starting dynamic subtest: vecs0
[517.833686] Dynamic subtest vecs0: SUCCESS (0.044s)
[517.843757] Starting dynamic subtest: ccs0
[517.890502] Dynamic subtest ccs0: SUCCESS (0.056s)
[517.891426] Subtest submit-early-slice: SUCCESS (0.314s)
[518.980080] [108/133] (512s left) gem_exec_balancer (parallel-bb-first)
[519.252154] Starting subtest: parallel-bb-first
[520.245554] Subtest parallel-bb-first: SUCCESS (0.994s)
[520.887287] [109/133] (510s left) gen9_exec_parse (bb-large)
[520.950443] Subtest bb-large: SKIP (0.000s)
[521.042645] [110/133] (510s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[521.162947] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[521.163780] Starting dynamic subtest: pipe-A-eDP-1
[521.185204] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[521.194099] Starting dynamic subtest: pipe-B-eDP-1
[521.215010] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[521.223270] Starting dynamic subtest: pipe-C-eDP-1
[521.243545] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[521.251495] Starting dynamic subtest: pipe-D-eDP-1
[521.271549] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[521.273071] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[523.311620] [111/133] (508s left) api_intel_bb (simple-bb-ctx)
[523.371504] Starting subtest: simple-bb-ctx
[523.386708] Subtest simple-bb-ctx: SUCCESS (0.015s)
[523.505162] [112/133] (508s left) gem_ctx_isolation (preservation-s3)
[523.573459] Starting subtest: preservation-S3
[523.574491] Starting dynamic subtest: rcs0
[540.338460] Dynamic subtest rcs0: SUCCESS (1.722s)
[540.347795] Starting dynamic subtest: bcs0
[557.353947] Dynamic subtest bcs0: SUCCESS (1.731s)
[557.362433] Starting dynamic subtest: vcs0
[574.349776] Dynamic subtest vcs0: SUCCESS (3.333s)
[574.358816] Starting dynamic subtest: vcs1
[592.350664] Dynamic subtest vcs1: SUCCESS (5.045s)
[592.360028] Starting dynamic subtest: vecs0
[610.364336] Dynamic subtest vecs0: SUCCESS (4.989s)
[610.374313] Starting dynamic subtest: ccs0
[628.359604] Dynamic subtest ccs0: SUCCESS (3.142s)
[628.360410] Subtest preservation-S3: SUCCESS (19.968s)
[634.606706] [113/133] (403s left) sriov_basic (enable-vfs-autoprobe-on)
[634.673347] Starting subtest: enable-vfs-autoprobe-on
[634.674560] Starting dynamic subtest: numvfs-1
[634.705192] Dynamic subtest numvfs-1: FAIL (0.013s)
[634.714185] Starting dynamic subtest: numvfs-2
[634.742286] Dynamic subtest numvfs-2: FAIL (0.004s)
[634.750798] Starting dynamic subtest: numvfs-3
[634.778749] Dynamic subtest numvfs-3: FAIL (0.007s)
[634.787945] Starting dynamic subtest: numvfs-4
[634.813783] Dynamic subtest numvfs-4: FAIL (0.004s)
[634.821974] Starting dynamic subtest: numvfs-5
[634.847361] Dynamic subtest numvfs-5: FAIL (0.004s)
[634.855305] Starting dynamic subtest: numvfs-6
[634.880691] Dynamic subtest numvfs-6: FAIL (0.004s)
[634.888685] Starting dynamic subtest: numvfs-7
[634.915475] Dynamic subtest numvfs-7: FAIL (0.004s)
[634.923602] Starting dynamic subtest: numvfs-random
[634.948987] Dynamic subtest numvfs-random: FAIL (0.004s)
[634.956860] Starting dynamic subtest: numvfs-all
[634.982242] Dynamic subtest numvfs-all: FAIL (0.005s)
[634.983054] Subtest enable-vfs-autoprobe-on: FAIL (0.057s)
[635.012199] [114/133] (402s left) perf_pmu (gt-awake)
[635.049717] Starting subtest: gt-awake
[643.718424] Subtest gt-awake: SUCCESS (8.645s)
[643.788027] [115/133] (394s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[643.843742] Subtest no-spare-fences-busy: SKIP (0.000s)
[643.923541] [116/133] (393s left) kms_rotation_crc (primary-rotation-90)
[644.018879] Starting subtest: primary-rotation-90
[644.020786] Subtest primary-rotation-90: SKIP (0.001s)
[644.068388] [117/133] (393s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[644.171402] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[644.944529] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.772s)
[645.122818] [118/133] (392s left) gem_mmap_wc (write-prefaulted)
[645.190216] Subtest write-prefaulted: SKIP (0.000s)
[645.270243] [119/133] (392s left) gem_pxp (reject-modify-context-protection-off-1)
[645.394449] Starting subtest: reject-modify-context-protection-off-1
[645.395959] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[645.485907] [120/133] (392s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[645.573184] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[645.574164] Starting dynamic subtest: pipe-A-eDP-1
[645.595493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[645.605640] Starting dynamic subtest: pipe-B-eDP-1
[645.618517] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[645.628558] Starting dynamic subtest: pipe-C-eDP-1
[645.641202] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[645.650730] Starting dynamic subtest: pipe-D-eDP-1
[645.664232] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[645.665021] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[647.941386] [121/133] (390s left) kms_plane_lowres (tiling-x)
[648.043061] Starting subtest: tiling-x
[648.043910] Starting dynamic subtest: pipe-A-eDP-1
[648.045761] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[648.339471] Starting dynamic subtest: pipe-B-eDP-1
[648.341560] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[648.350064] Starting dynamic subtest: pipe-C-eDP-1
[648.352014] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[648.360480] Starting dynamic subtest: pipe-D-eDP-1
[648.362406] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[648.364159] Subtest tiling-x: SKIP (0.294s)
[649.168090] [122/133] (388s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[649.259282] Starting subtest: multiplane-rotation-cropping-top
[666.625955] Subtest multiplane-rotation-cropping-top: SUCCESS (17.360s)
[666.761475] [123/133] (371s left) gem_mmap_gtt (basic-write-read-distinct)
[666.825144] Subtest basic-write-read-distinct: SKIP (0.000s)
[666.901057] [124/133] (371s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[667.001274] Starting subtest: fbc-psr2-sprite-mmap-gtt
[667.002210] Starting dynamic subtest: eDP-1
[667.004206] Dynamic subtest eDP-1: SKIP (0.000s)
[667.005892] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[667.048327] [125/133] (371s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[667.151697] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[667.153638] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[667.197038] [126/133] (371s left) gem_tiled_partial_pwrite_pread (writes)
[667.260766] Subtest writes: SKIP (0.000s)
[667.345203] [127/133] (370s left) kms_atomic (crtc-invalid-params-fence)
[667.438580] Starting subtest: crtc-invalid-params-fence
[667.439592] Starting dynamic subtest: pipe-A-eDP-1
[667.848514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[667.849487] Subtest crtc-invalid-params-fence: SUCCESS (0.411s)
[668.703535] [128/133] (369s left) gem_busy (parallel)
[668.897373] Starting subtest: parallel
[668.898534] Starting dynamic subtest: rcs0
[670.724634] Dynamic subtest rcs0: SUCCESS (1.824s)
[670.736198] Starting dynamic subtest: bcs0
[672.707478] Dynamic subtest bcs0: SUCCESS (1.981s)
[672.722048] Starting dynamic subtest: vcs0
[674.692130] Dynamic subtest vcs0: SUCCESS (1.982s)
[674.708637] Starting dynamic subtest: vcs1
[676.739406] Dynamic subtest vcs1: SUCCESS (2.045s)
[676.750439] Starting dynamic subtest: vecs0
[678.724204] Dynamic subtest vecs0: SUCCESS (1.982s)
[678.735313] Starting dynamic subtest: ccs0
[680.709639] Dynamic subtest ccs0: SUCCESS (1.983s)
[680.711000] Subtest parallel: SUCCESS (11.812s)
[680.903207] [129/133] (357s left) gem_ctx_persistence (processes)
[680.952954] Starting subtest: processes
[682.684969] Subtest processes: SUCCESS (1.732s)
[682.738351] [130/133] (355s left) kms_big_fb (4-tiled-addfb-size-overflow)
[682.844293] Starting subtest: 4-tiled-addfb-size-overflow
[682.845133] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[682.919614] [131/133] (355s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[683.007655] Starting subtest: x-tiled-64bpp-rotate-270
[683.027726] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[683.114431] [132/133] (355s left) kms_plane_scaling (planes-scaler-unity-scaling)
[683.197212] Starting subtest: planes-scaler-unity-scaling
[683.198035] Starting dynamic subtest: pipe-A
[683.260979] Dynamic subtest pipe-A: SUCCESS (0.064s)
[683.272341] Starting dynamic subtest: pipe-B
[684.452034] Dynamic subtest pipe-B: SUCCESS (1.190s)
[684.465019] Starting dynamic subtest: pipe-C
[685.561916] Dynamic subtest pipe-C: SUCCESS (1.108s)
[685.573696] Starting dynamic subtest: pipe-D
[686.698119] Dynamic subtest pipe-D: SUCCESS (1.135s)
[686.699044] Subtest planes-scaler-unity-scaling: SUCCESS (3.502s)
[687.836072] [133/133] (350s left) gem_exec_whisper (basic-contexts)
[687.904468] Starting subtest: basic-contexts
[693.958064] Subtest basic-contexts: SUCCESS (6.052s)
[694.115013] Closing watchdogs
results: parsing output: 0/ for test: api_intel_allocator
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_pipe_crc_basic
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: testdisplay
results: parsing output: 11/ for test: prime_mmap
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: gem_softpin
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: gem_wait
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: gem_exec_flush
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_chamelium_edid
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_pm_dc
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_color_pipeline
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_mmap_offset
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_close_race
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: i915_module_load
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: gen9_exec_parse
results: parsing output: 48/ for test: kms_cursor_edge_walk
results: parsing output: 49/ for test: gem_render_copy_redux
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_fenced_exec_thrash
results: parsing output: 55/ for test: kms_hdr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_lmem_swapping
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: i915_pm_rpm
results: parsing output: 63/ for test: gem_exec_whisper
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: kms_vrr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_prop_blob
results: parsing output: 70/ for test: kms_properties
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_unref_active_buffers
results: parsing output: 76/ for test: gem_caching
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: gem_exec_create
results: parsing output: 79/ for test: kms_content_protection
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_feature_discovery
results: parsing output: 83/ for test: core_setmaster
results: parsing output: 84/ for test: kms_pm_rpm
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_mmap_wc
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_exec_alignment
results: parsing output: 93/ for test: kms_getfb
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_flip_tiling
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_ringfill
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: gem_ctx_isolation
results: parsing output: 112/ for test: sriov_basic
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_fenced_exec_thrash
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_mmap_wc
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_plane_lowres
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 126/ for test: kms_atomic
results: parsing output: 127/ for test: gem_busy
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: gem_exec_whisper
Done.