[59.604779] Initializing watchdogs
[59.604828]   /dev/watchdog0
[59.618254] [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]
[59.622638] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.624753] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.627778] [001/133] (960s left) kms_psr (fbc-pr-primary-blt)
[59.743787] Starting subtest: fbc-pr-primary-blt
[59.747827] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[59.808683] [002/133] (960s left) device_reset (cold-reset-bound)
[59.858831] Starting subtest: cold-reset-bound
[59.863428] Subtest cold-reset-bound: SKIP (0.000s)
[59.923712] [003/133] (960s left) gem_exec_params (mmapped)
[59.987241] Starting subtest: mmapped
[59.991560] Subtest mmapped: SUCCESS (0.007s)
[60.114737] [004/133] (960s left) kms_flip (absolute-wf_vblank)
[60.208723] Starting subtest: absolute-wf_vblank
[60.211050] Starting dynamic subtest: A-eDP1
[68.953766] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[68.962662] Starting dynamic subtest: B-eDP1
[77.678803] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[77.690518] Starting dynamic subtest: C-eDP1
[86.394960] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[86.401732] Starting dynamic subtest: D-eDP1
[95.127015] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[95.132268] Subtest absolute-wf_vblank: SUCCESS (34.924s)
[96.329864] [005/133] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[96.429654] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[103.522039] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.097s)
[103.646078] [006/133] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[103.745623] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[103.750080] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[103.833669] [007/133] (916s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[103.949342] Starting subtest: cursorA-vs-flipB-varying-size
[103.953983] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[104.095957] [008/133] (916s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[104.191035] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[104.195430] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[104.258869] [009/133] (916s left) i915_drm_fdinfo (isolation)
[104.297777] Starting subtest: isolation
[104.300032] Starting dynamic subtest: rcs0
[104.320023] Dynamic subtest rcs0: SKIP (0.020s)
[104.328687] Starting dynamic subtest: bcs0
[104.333404] Dynamic subtest bcs0: SKIP (0.000s)
[104.339637] Starting dynamic subtest: vcs0
[104.343751] Dynamic subtest vcs0: SKIP (0.000s)
[104.350245] Starting dynamic subtest: vcs1
[104.354630] Dynamic subtest vcs1: SKIP (0.000s)
[104.361516] Starting dynamic subtest: vecs0
[104.366116] Dynamic subtest vecs0: SKIP (0.000s)
[104.372577] Starting dynamic subtest: ccs0
[104.377049] Dynamic subtest ccs0: SKIP (0.000s)
[104.381409] Subtest isolation: SKIP (0.023s)
[104.414398] [010/133] (916s left) gem_exec_fence (submit3)
[104.593336] Starting subtest: submit3
[104.597786] Subtest submit3: SKIP (0.000s)
[105.953637] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[105.957092] [011/133] (914s left) kms_lease (implicit-plane-lease)
[106.041576] Starting subtest: implicit-plane-lease
[106.043954] Subtest implicit-plane-lease: SUCCESS (0.002s)
[106.151105] [012/133] (914s left) gem_workarounds (suspend-resume)
[106.210712] Starting subtest: suspend-resume
[122.751896] Subtest suspend-resume: SUCCESS (1.327s)
[122.877766] [013/133] (897s left) kms_flip (flip-vs-modeset-vs-hang)
[122.980837] Starting subtest: flip-vs-modeset-vs-hang
[122.983663] Starting dynamic subtest: A-eDP1
[162.587300] Dynamic subtest A-eDP1: SUCCESS (39.602s)
[162.597817] Starting dynamic subtest: D-eDP1
[212.569884] Dynamic subtest D-eDP1: SUCCESS (49.980s)
[212.572808] Subtest flip-vs-modeset-vs-hang: SUCCESS (89.589s)
[212.945529] [014/133] (807s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[212.990538] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[213.030213] [015/133] (807s left) i915_query (query-topology-known-pci-ids)
[213.086864] Starting subtest: query-topology-known-pci-ids
[213.092884] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[213.182311] [016/133] (807s left) api_intel_bb (object-reloc-purge-cache)
[213.241640] Starting subtest: object-reloc-purge-cache
[213.250536] Subtest object-reloc-purge-cache: SKIP (0.006s)
[213.334682] [017/133] (807s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[213.432368] Starting subtest: random-ccs-data-yf-tiled-ccs
[213.434921] Starting dynamic subtest: pipe-A-eDP-1
[213.462827] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.471744] Starting dynamic subtest: pipe-B-eDP-1
[213.499568] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.507608] Starting dynamic subtest: pipe-C-eDP-1
[213.535679] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.543738] Starting dynamic subtest: pipe-D-eDP-1
[213.572827] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.577607] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[215.695555] [018/133] (805s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[215.790767] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[215.796456] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[215.883663] [019/133] (804s left) gem_eio (wait-wedge-1us)
[216.056158] Starting subtest: wait-wedge-1us
[217.143765] Subtest wait-wedge-1us: SUCCESS (1.088s)
[217.255881] [020/133] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[217.364877] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[217.369236] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[217.455335] [021/133] (803s left) drm_read (short-buffer-block)
[217.604707] Starting subtest: short-buffer-block
[217.607412] Subtest short-buffer-block: SUCCESS (0.000s)
[217.718005] [022/133] (803s left) i915_pm_sseu (full-enable)
[217.784038] Subtest full-enable: SKIP (0.000s)
[217.889008] [023/133] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[217.986694] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[217.992295] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[218.066484] [024/133] (802s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[218.448563] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[219.228345] [025/133] (801s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[219.323548] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[219.326242] Starting dynamic subtest: pipe-A-eDP-1
[219.378817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.057s)
[219.388086] Starting dynamic subtest: pipe-B-eDP-1
[219.439978] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[219.448754] Starting dynamic subtest: pipe-C-eDP-1
[219.501712] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[219.510856] Starting dynamic subtest: pipe-D-eDP-1
[219.561550] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[219.564110] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.241s)
[221.830460] [026/133] (799s left) kms_content_protection (srm)
[221.996858] Starting subtest: srm
[222.005209] Subtest srm: SKIP (0.003s)
[222.108775] [027/133] (799s left) kms_sequence (get-forked-busy)
[222.202569] Starting subtest: get-forked-busy
[222.205122] Starting dynamic subtest: pipe-A-eDP-1
[224.125677] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[224.135619] Starting dynamic subtest: pipe-B-eDP-1
[226.737358] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.609s)
[226.746460] Starting dynamic subtest: pipe-C-eDP-1
[229.331413] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.593s)
[229.340817] Starting dynamic subtest: pipe-D-eDP-1
[231.859541] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.528s)
[231.862509] Subtest get-forked-busy: SUCCESS (9.656s)
[232.652191] [028/133] (788s left) gen9_exec_parse (bb-start-far)
[232.710987] Subtest bb-start-far: SKIP (0.000s)
[232.784019] [029/133] (788s left) gem_softpin (safe-alignment)
[232.832604] Starting subtest: safe-alignment
[232.857703] Subtest safe-alignment: SUCCESS (0.026s)
[234.155015] [030/133] (787s left) kms_psr (fbc-psr-primary-mmap-cpu)
[234.250125] Starting subtest: fbc-psr-primary-mmap-cpu
[234.252666] Starting dynamic subtest: eDP-1
[234.257675] Dynamic subtest eDP-1: SKIP (0.000s)
[234.262714] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[234.320625] [031/133] (787s left) kms_big_fb (linear-32bpp-rotate-90)
[234.439093] Starting subtest: linear-32bpp-rotate-90
[234.460048] Subtest linear-32bpp-rotate-90: SKIP (0.021s)
[234.562031] [032/133] (786s left) gem_mmap_gtt (basic-read-write-distinct)
[234.611719] Subtest basic-read-write-distinct: SKIP (0.000s)
[234.666620] [033/133] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[234.761610] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[234.766670] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[234.867225] [034/133] (786s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[234.952438] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[234.954757] Starting dynamic subtest: pipe-A-eDP-1
[234.976638] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[234.987177] Starting dynamic subtest: pipe-B-eDP-1
[235.007847] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[235.015535] Starting dynamic subtest: pipe-C-eDP-1
[235.036588] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[235.045169] Starting dynamic subtest: pipe-D-eDP-1
[235.065380] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[235.067466] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[237.203040] [035/133] (784s left) gem_ctx_shared (q-out-order)
[237.279810] Starting subtest: Q-out-order
[237.282698] Starting dynamic subtest: rcs0
[237.393691] Dynamic subtest rcs0: SUCCESS (0.115s)
[237.408559] Starting dynamic subtest: vcs0
[237.469040] Dynamic subtest vcs0: SUCCESS (0.076s)
[237.485348] Starting dynamic subtest: vcs1
[237.543587] Dynamic subtest vcs1: SUCCESS (0.074s)
[237.559464] Starting dynamic subtest: vecs0
[237.619348] Dynamic subtest vecs0: SUCCESS (0.075s)
[237.635397] Starting dynamic subtest: ccs0
[237.713047] Dynamic subtest ccs0: SUCCESS (0.093s)
[237.715812] Subtest Q-out-order: SUCCESS (0.436s)
[239.205795] [036/133] (782s left) gem_exec_schedule (lateslice)
[239.287503] Starting subtest: lateslice
[239.289796] Starting dynamic subtest: rcs0
[239.295972] Dynamic subtest rcs0: SUCCESS (0.023s)
[239.304648] Starting dynamic subtest: bcs0
[239.313041] Dynamic subtest bcs0: SUCCESS (0.016s)
[239.321877] Starting dynamic subtest: vcs0
[239.331415] Dynamic subtest vcs0: SUCCESS (0.018s)
[239.340619] Starting dynamic subtest: vcs1
[239.349337] Dynamic subtest vcs1: SUCCESS (0.017s)
[239.358159] Starting dynamic subtest: vecs0
[239.374393] Dynamic subtest vecs0: SUCCESS (0.025s)
[239.385368] Starting dynamic subtest: ccs0
[239.397736] Dynamic subtest ccs0: SUCCESS (0.022s)
[239.400697] Subtest lateslice: SUCCESS (0.125s)
[241.242968] [037/133] (780s left) kms_plane (pixel-format-4-tiled-modifier)
[241.340582] Starting subtest: pixel-format-4-tiled-modifier
[241.373388] Starting dynamic subtest: pipe-A-plane-0
[242.084627] Dynamic subtest pipe-A-plane-0: SUCCESS (0.711s)
[242.093997] Starting dynamic subtest: pipe-A-plane-3
[242.550302] Dynamic subtest pipe-A-plane-3: SUCCESS (0.465s)
[242.558825] Starting dynamic subtest: pipe-A-plane-5
[242.563119] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[243.698450] Starting dynamic subtest: pipe-B-plane-0
[244.402663] Dynamic subtest pipe-B-plane-0: SUCCESS (0.711s)
[244.412118] Starting dynamic subtest: pipe-B-plane-3
[244.868827] Dynamic subtest pipe-B-plane-3: SUCCESS (0.466s)
[244.876877] Starting dynamic subtest: pipe-B-plane-5
[244.880579] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[245.180421] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.840s)
[245.982714] [038/133] (775s left) kms_atomic (crtc-invalid-params-fence)
[246.087234] Starting subtest: crtc-invalid-params-fence
[246.089591] Starting dynamic subtest: pipe-A-eDP-1
[246.507418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[246.510206] Subtest crtc-invalid-params-fence: SUCCESS (0.422s)
[247.322118] [039/133] (774s left) kms_cursor_crc (cursor-offscreen-32x32)
[247.470650] Starting subtest: cursor-offscreen-32x32
[247.513137] Subtest cursor-offscreen-32x32: SKIP (0.040s)
[247.805085] [040/133] (773s left) kms_cursor_edge_walk (128x128-top-edge)
[247.898533] Starting subtest: 128x128-top-edge
[247.901253] Starting dynamic subtest: pipe-A-eDP-1
[251.394605] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[251.404754] Starting dynamic subtest: pipe-D-eDP-1
[254.523833] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[254.526365] Subtest 128x128-top-edge: SUCCESS (6.623s)
[255.330391] [041/133] (766s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[255.429754] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[255.432651] Starting dynamic subtest: pipe-A
[255.450529] Dynamic subtest pipe-A: SKIP (0.017s)
[255.460452] Starting dynamic subtest: pipe-B
[255.480535] Dynamic subtest pipe-B: SKIP (0.029s)
[255.489558] Starting dynamic subtest: pipe-C
[255.510161] Dynamic subtest pipe-C: SKIP (0.030s)
[255.518889] Starting dynamic subtest: pipe-D
[255.540537] Dynamic subtest pipe-D: SKIP (0.029s)
[255.545291] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.107s)
[255.640111] [042/133] (766s left) kms_pm_rpm (dpms-non-lpsp)
[257.271818] Starting subtest: dpms-non-lpsp
[257.277831] Subtest dpms-non-lpsp: SKIP (0.001s)
[257.873371] [043/133] (763s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[257.976990] Starting subtest: multiplane-rotation-cropping-top
[275.582087] Subtest multiplane-rotation-cropping-top: SUCCESS (17.605s)
[275.686247] [044/133] (746s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[275.779069] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[275.783101] Starting dynamic subtest: A-eDP1
[284.712060] Dynamic subtest A-eDP1: SUCCESS (8.930s)
[284.720747] Starting dynamic subtest: B-eDP1
[293.645959] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[293.673712] Starting dynamic subtest: C-eDP1
[302.576770] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[302.588383] Starting dynamic subtest: D-eDP1
[311.511099] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[311.517739] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.735s)
[312.762323] [045/133] (709s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[312.874629] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[312.879433] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[312.977215] [046/133] (709s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[313.072665] Starting subtest: plane-all-modeset-transition-internal-panels
[313.075068] Starting dynamic subtest: pipe-A-eDP-1
[314.372161] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.300s)
[314.663856] Starting dynamic subtest: pipe-B-eDP-1
[315.703849] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.047s)
[315.971739] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.901s)
[316.822408] [047/133] (705s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[316.924670] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[316.929759] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[317.002569] [048/133] (705s left) gem_exec_whisper (basic-normal)
[317.066536] Starting subtest: basic-normal
[322.169654] Subtest basic-normal: SUCCESS (5.100s)
[322.352684] [049/133] (699s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[322.452811] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[322.455124] Starting dynamic subtest: pipe-A-default-mode
[325.178004] Dynamic subtest pipe-A-default-mode: SUCCESS (2.723s)
[325.180399] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.724s)
[325.996917] [050/133] (696s left) intel_hwmon (hwmon-write)
[326.079652] Subtest hwmon-write: SKIP (0.000s)
[326.137537] [051/133] (696s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[326.229641] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[333.115432] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.887s)
[333.242335] [052/133] (688s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[333.346643] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[333.349384] Starting dynamic subtest: pipe-A-eDP-1
[333.374661] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[333.383829] Starting dynamic subtest: pipe-B-eDP-1
[333.408956] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[333.417441] Starting dynamic subtest: pipe-C-eDP-1
[333.443668] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[333.454807] Starting dynamic subtest: pipe-D-eDP-1
[333.481029] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[333.486362] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[335.539911] [053/133] (686s left) prime_mmap (test_invalid_sync_flags)
[335.596858] Starting subtest: test_invalid_sync_flags
[335.599808] Starting dynamic subtest: test_invalid_sync_flags-smem
[335.602639] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[335.605545] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[335.697186] [054/133] (686s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[335.750132] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[335.830042] [055/133] (686s left) kms_chamelium_hpd (vga-hpd-fast)
[336.213809] Subtest vga-hpd-fast: SKIP (0.000s)
[337.028554] [056/133] (685s left) perf_pmu (init-wait)
[337.071620] Starting subtest: init-wait
[337.074596] Starting dynamic subtest: rcs0
[337.077552] Dynamic subtest rcs0: SUCCESS (0.002s)
[337.087617] Starting dynamic subtest: bcs0
[337.090312] Dynamic subtest bcs0: SUCCESS (0.001s)
[337.099188] Starting dynamic subtest: vcs0
[337.101711] Dynamic subtest vcs0: SUCCESS (0.001s)
[337.110426] Starting dynamic subtest: vcs1
[337.112618] Dynamic subtest vcs1: SUCCESS (0.001s)
[337.121461] Starting dynamic subtest: vecs0
[337.124072] Dynamic subtest vecs0: SUCCESS (0.001s)
[337.132897] Starting dynamic subtest: ccs0
[337.135717] Dynamic subtest ccs0: SUCCESS (0.001s)
[337.138670] Subtest init-wait: SUCCESS (0.009s)
[337.179701] [057/133] (685s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[337.282394] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[338.372645] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.090s)
[338.492070] [058/133] (683s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[338.578805] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[338.581341] Starting dynamic subtest: pipe-A
[338.917115] Dynamic subtest pipe-A: SUCCESS (0.340s)
[338.925617] Starting dynamic subtest: pipe-B
[340.376189] Dynamic subtest pipe-B: SUCCESS (1.458s)
[340.384684] Starting dynamic subtest: pipe-C
[341.785644] Dynamic subtest pipe-C: SUCCESS (1.408s)
[341.796843] Starting dynamic subtest: pipe-D
[343.219273] Dynamic subtest pipe-D: SUCCESS (1.432s)
[343.222184] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.642s)
[344.369326] [059/133] (678s left) syncobj_wait (invalid-reset-zero-handles)
[344.432280] Starting subtest: invalid-reset-zero-handles
[344.434829] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[344.530457] [060/133] (678s left) kms_flip_tiling (flip-change-tiling)
[344.624470] Starting subtest: flip-change-tiling
[344.626715] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[344.800434] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.177s)
[344.812861] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[344.945362] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[344.958025] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[345.079101] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[345.091202] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[345.222578] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[345.235332] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[345.366822] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[345.379402] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[345.511088] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[345.527603] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[345.656271] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[345.676849] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[345.766990] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[345.778464] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[345.900623] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[345.910678] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[346.044709] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[346.056403] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[346.188471] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.141s)
[346.200299] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[346.333368] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[346.344816] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[346.465953] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[346.475769] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[346.612610] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.143s)
[346.626446] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[346.721741] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[346.731591] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[346.867051] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[346.878322] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[347.011227] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[347.023376] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[347.155623] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[347.166434] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[347.300127] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[347.312295] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[347.444736] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[347.456419] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[347.589257] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[347.601885] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[347.710594] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.119s)
[347.721260] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[347.866117] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.153s)
[347.878903] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[348.011123] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[348.022014] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[348.154765] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[348.165696] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[348.299593] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s)
[348.311426] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[348.443831] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[348.455493] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[348.588223] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[348.600014] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[348.710380] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[348.720620] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[348.855454] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[348.867685] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[348.999614] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[349.010886] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[349.144431] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[349.156325] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[349.289467] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[349.302360] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[349.432867] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[349.447721] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[349.605381] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.169s)
[349.616568] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[349.738703] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.131s)
[349.791394] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[351.039489] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.255s)
[351.053140] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[351.184821] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[351.194765] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[351.318068] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.130s)
[351.327998] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[351.461767] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[351.473865] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[351.616439] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.153s)
[351.628676] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[351.788809] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.170s)
[351.801453] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[351.933683] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[351.946032] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[352.054971] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.119s)
[352.067208] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[352.189806] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[352.205191] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[352.344528] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.153s)
[352.356990] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[352.489544] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[352.501503] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[352.660836] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.169s)
[352.672893] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[352.793922] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[352.804840] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[352.929129] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[352.941474] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[353.038127] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[353.050744] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[353.183319] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[353.194775] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[353.327533] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[353.339145] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[353.472289] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[353.484656] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[353.616393] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[353.627515] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[353.761007] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[353.771648] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[353.905366] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[353.916358] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[354.027019] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.119s)
[354.040853] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[354.203471] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.173s)
[354.219818] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[354.348168] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[354.361845] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[354.492551] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[354.503992] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[354.637264] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[354.648322] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[354.780595] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[354.794437] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[354.925287] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[354.935991] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[355.047376] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[355.059255] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[355.192432] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.143s)
[355.204295] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[355.337208] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[355.348451] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[355.481156] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[355.500413] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[355.625498] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.141s)
[355.638341] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[355.769739] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[355.784404] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[355.946686] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.173s)
[355.958472] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[356.079590] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.130s)
[356.130857] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[357.367547] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.242s)
[357.378812] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[357.467422] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[357.478372] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[357.566940] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[357.577837] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[357.678341] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[357.689848] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[357.789340] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[357.802831] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[357.900148] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[357.911487] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[358.000584] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[358.016567] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[358.100598] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.097s)
[358.111545] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[358.200464] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[358.211379] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[358.311589] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[358.322218] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[358.433374] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.121s)
[358.443223] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[358.544481] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[358.555832] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[358.644366] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[358.655017] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[358.745757] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[358.757232] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[358.844772] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[358.859047] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[358.955472] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.108s)
[358.966692] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[359.066649] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[359.077411] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[359.177349] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[359.193089] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[359.277723] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[359.289324] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[359.378364] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[359.390194] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[359.477843] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[359.489701] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[359.588846] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s)
[359.600599] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[359.700114] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.110s)
[359.711610] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[359.811188] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[359.821848] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[359.922390] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[359.933563] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[360.033217] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[360.044396] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[360.144420] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[360.155551] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[360.255705] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[360.266827] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[360.366836] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[360.378219] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[360.477774] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[360.489243] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[360.588818] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[360.601213] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[360.700376] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[360.712410] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[360.811443] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[360.823844] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[360.922360] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[360.936327] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[361.044842] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.120s)
[361.056524] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[361.155696] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[361.197602] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[362.393195] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.203s)
[362.405363] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[362.493850] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[362.508374] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[362.593597] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[362.603847] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[362.703888] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[362.715513] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[362.825580] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.120s)
[362.835191] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[362.936683] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[362.946819] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[363.037345] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[363.049063] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[363.137353] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[363.149615] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[363.237386] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[363.248890] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[363.348333] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[363.360016] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[363.458881] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[363.470016] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[363.569829] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[363.580420] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[363.670658] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[363.682767] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[363.770010] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[363.782327] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[363.870237] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[363.882201] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[363.981090] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[363.994488] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[364.091844] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[364.107980] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[364.203403] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[364.214483] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[364.314966] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[364.327531] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[364.414857] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[364.425307] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[364.526077] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s)
[364.537623] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[364.636834] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.108s)
[364.649481] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[364.748147] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.110s)
[364.758645] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[364.870676] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.121s)
[364.882248] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[364.981461] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[364.992878] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[365.131070] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.149s)
[365.143465] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[365.242082] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.108s)
[365.252802] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[365.353310] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[365.367356] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[365.464314] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[365.474718] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[365.586722] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.121s)
[365.597688] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[365.698444] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[365.709949] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[365.809824] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.108s)
[365.825394] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[365.919627] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[365.930815] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[366.030714] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[366.042069] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[366.153214] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.121s)
[366.165064] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[366.264563] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[366.297513] Subtest flip-change-tiling: SUCCESS (21.675s)
[367.488423] [061/133] (655s left) syncobj_timeline (invalid-transfer-bad-pad)
[367.550176] Starting subtest: invalid-transfer-bad-pad
[367.552841] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[367.634228] [062/133] (655s left) kms_addfb_basic (no-handle)
[367.698266] Starting subtest: no-handle
[367.701114] Subtest no-handle: SUCCESS (0.000s)
[367.817699] [063/133] (654s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[367.938328] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[376.892733] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.956s)
[377.730634] [064/133] (644s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[377.830735] Starting subtest: fbc-pr-sprite-mmap-gtt
[377.835823] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[377.903021] [065/133] (644s left) syncobj_timeline (etime-multi-wait-all-submitted)
[377.958678] Starting subtest: etime-multi-wait-all-submitted
[378.063208] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s)
[378.153138] [066/133] (644s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[378.273713] Starting subtest: 2x-long-cursor-vs-flip-legacy
[378.279593] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[378.417210] [067/133] (644s left) kms_color (ctm-signed)
[378.510634] Starting subtest: ctm-signed
[378.513071] Starting dynamic subtest: pipe-A-eDP-1
[380.612886] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.103s)
[380.622635] Starting dynamic subtest: pipe-B-eDP-1
[383.400377] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.786s)
[383.411968] Starting dynamic subtest: pipe-C-eDP-1
[386.104103] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.705s)
[386.113457] Starting dynamic subtest: pipe-D-eDP-1
[388.785682] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.677s)
[388.788143] Subtest ctm-signed: SUCCESS (10.274s)
[389.603231] [068/133] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[389.709738] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[396.339752] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.633s)
[396.489740] [069/133] (626s left) sw_sync (alloc_timeline)
[396.531734] Starting subtest: alloc_timeline
[396.534644] Subtest alloc_timeline: SUCCESS (0.000s)
[396.586297] [070/133] (626s left) kms_debugfs (display-off-read-all)
[396.678635] Starting subtest: display-off-read-all
[396.964661] Subtest display-off-read-all: SUCCESS (0.287s)
[397.789256] [071/133] (625s left) gem_mmap_wc (pf-nonblock)
[397.850052] Subtest pf-nonblock: SKIP (0.000s)
[397.907235] [072/133] (625s left) perf_pmu (busy)
[397.953767] Starting subtest: busy
[397.956338] Starting dynamic subtest: rcs0
[398.545381] Dynamic subtest rcs0: SUCCESS (0.592s)
[398.557673] Starting dynamic subtest: bcs0
[399.108064] Dynamic subtest bcs0: SUCCESS (0.560s)
[399.121127] Starting dynamic subtest: vcs0
[401.091332] Dynamic subtest vcs0: SUCCESS (1.979s)
[401.104134] Starting dynamic subtest: vcs1
[403.139144] Dynamic subtest vcs1: SUCCESS (2.045s)
[403.152478] Starting dynamic subtest: vecs0
[405.122394] Dynamic subtest vecs0: SUCCESS (1.980s)
[405.133324] Starting dynamic subtest: ccs0
[405.693196] Dynamic subtest ccs0: SUCCESS (0.569s)
[405.696143] Subtest busy: SUCCESS (7.741s)
[405.800354] [073/133] (617s left) prime_vgem (fence-flip-hang)
[405.885024] Subtest fence-flip-hang: SKIP (0.000s)
[405.986961] [074/133] (617s left) kms_psr (psr2-basic)
[406.089106] Starting subtest: psr2-basic
[406.091436] Starting dynamic subtest: eDP-1
[407.745677] Dynamic subtest eDP-1: SUCCESS (1.657s)
[407.748618] Subtest psr2-basic: SUCCESS (1.658s)
[408.546210] [075/133] (614s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[408.634529] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[408.637429] Starting dynamic subtest: pipe-A-eDP-1
[408.704474] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[408.717073] Starting dynamic subtest: pipe-B-eDP-1
[408.784609] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[408.794599] Starting dynamic subtest: pipe-C-eDP-1
[408.862534] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[408.872480] Starting dynamic subtest: pipe-D-eDP-1
[408.941947] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[408.947373] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.011s)
[410.820882] [076/133] (612s left) api_intel_allocator (default-alignment)
[410.890419] Starting subtest: default-alignment
[410.896572] Subtest default-alignment: SUCCESS (0.005s)
[410.997083] [077/133] (612s left) gem_exec_params (secure-non-root)
[411.051688] Starting subtest: secure-non-root
[411.057317] Subtest secure-non-root: SKIP (0.000s)
[411.196583] [078/133] (612s left) gem_mmap_offset (perf)
[411.242747] Starting subtest: perf
[411.245554] Starting dynamic subtest: smem0
[411.620015] Dynamic subtest smem0: SUCCESS (0.376s)
[411.622866] Subtest perf: SUCCESS (0.377s)
[411.754498] [079/133] (611s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[411.872429] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[411.877523] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[412.016058] [080/133] (611s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[412.116761] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[418.727048] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.616s)
[418.862137] [081/133] (604s left) gem_wait (write-busy)
[418.917471] Starting subtest: write-busy
[418.920084] Starting dynamic subtest: all-engines
[419.529519] Dynamic subtest all-engines: SUCCESS (0.612s)
[419.540615] Starting dynamic subtest: rcs0
[420.088646] Dynamic subtest rcs0: SUCCESS (0.556s)
[420.105837] Starting dynamic subtest: bcs0
[420.640768] Dynamic subtest bcs0: SUCCESS (0.552s)
[420.656381] Starting dynamic subtest: vcs0
[422.146498] Dynamic subtest vcs0: SUCCESS (1.503s)
[422.163216] Starting dynamic subtest: vcs1
[424.130351] Dynamic subtest vcs1: SUCCESS (1.981s)
[424.147604] Starting dynamic subtest: vecs0
[426.114774] Dynamic subtest vecs0: SUCCESS (1.981s)
[426.132537] Starting dynamic subtest: ccs0
[426.669038] Dynamic subtest ccs0: SUCCESS (0.552s)
[426.671816] Subtest write-busy: SUCCESS (7.752s)
[426.870071] [082/133] (596s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[426.973987] Starting subtest: fbc-shrfb-scaledprimary
[429.919717] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.949s)
[431.045479] [083/133] (592s left) syncobj_basic (bad-pad-handle-to-fd)
[431.106817] Starting subtest: bad-pad-handle-to-fd
[431.109701] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[431.207237] [084/133] (592s left) syncobj_timeline (single-wait-for-submit-signaled)
[431.259607] Starting subtest: single-wait-for-submit-signaled
[431.262343] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[431.362626] [085/133] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[431.472652] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[431.477743] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[431.569491] [086/133] (592s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[431.672314] Starting subtest: fbc-rgb101010-draw-mmap-wc
[436.224289] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.557s)
[437.333147] [087/133] (586s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[437.383684] Starting subtest: invalid-multi-wait-all-unsubmitted
[437.386164] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[437.483768] [088/133] (586s left) gem_sync (basic-store-all)
[437.548614] Starting subtest: basic-store-all
[442.030602] Subtest basic-store-all: SUCCESS (4.494s)
[442.216617] [089/133] (581s left) kms_properties (crtc-properties-atomic)
[442.321435] Starting subtest: crtc-properties-atomic
[442.324050] Starting dynamic subtest: pipe-A-eDP-1
[442.772157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[442.782289] Starting dynamic subtest: pipe-B-eDP-1
[443.898850] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[443.908822] Starting dynamic subtest: pipe-C-eDP-1
[445.023564] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[445.033373] Starting dynamic subtest: pipe-D-eDP-1
[446.162393] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.137s)
[446.164827] Subtest crtc-properties-atomic: SUCCESS (3.842s)
[446.967483] [090/133] (576s left) gem_ctx_exec (basic-close-race)
[447.022316] Starting subtest: basic-close-race
[453.038470] Subtest basic-close-race: SUCCESS (6.015s)
[453.153792] [091/133] (570s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[453.252400] Starting subtest: psr-indfb-scaledprimary
[459.043628] Subtest psr-indfb-scaledprimary: SUCCESS (5.794s)
[459.161191] [092/133] (564s left) kms_cursor_crc (cursor-size-hints)
[459.279659] Starting subtest: cursor-size-hints
[459.282366] Starting dynamic subtest: pipe-A-eDP-1
[459.896514] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.616s)
[459.906409] Starting dynamic subtest: pipe-D-eDP-1
[461.150621] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.252s)
[461.153271] Subtest cursor-size-hints: SUCCESS (1.871s)
[461.955470] [093/133] (562s left) kms_vblank (ts-continuation-idle-hang)
[462.053472] Starting subtest: ts-continuation-idle-hang
[462.055588] Starting dynamic subtest: pipe-A-eDP-1
[488.900437] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.845s)
[488.918268] Starting dynamic subtest: pipe-D-eDP-1
[503.882853] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.980s)
[503.885732] Subtest ts-continuation-idle-hang: SUCCESS (41.829s)
[504.742160] [094/133] (519s left) gem_eio (wait-1us)
[504.935711] Starting subtest: wait-1us
[505.230564] Subtest wait-1us: SUCCESS (0.294s)
[505.373340] [095/133] (518s left) gem_exec_balancer (parallel-keep-in-fence)
[505.626115] Starting subtest: parallel-keep-in-fence
[506.840060] Subtest parallel-keep-in-fence: SUCCESS (1.214s)
[506.948341] [096/133] (517s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[507.055939] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[514.536711] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.485s)
[514.648478] [097/133] (509s left) prime_busy (before-wait)
[514.717443] Starting subtest: before-wait
[514.720083] Starting dynamic subtest: rcs0
[514.752416] Dynamic subtest rcs0: SUCCESS (0.034s)
[514.763203] Starting dynamic subtest: bcs0
[514.795554] Dynamic subtest bcs0: SUCCESS (0.043s)
[514.812747] Starting dynamic subtest: vcs0
[514.839298] Dynamic subtest vcs0: SUCCESS (0.042s)
[514.851766] Starting dynamic subtest: vcs1
[514.881289] Dynamic subtest vcs1: SUCCESS (0.041s)
[514.891701] Starting dynamic subtest: vecs0
[514.923449] Dynamic subtest vecs0: SUCCESS (0.041s)
[514.932833] Starting dynamic subtest: ccs0
[514.965747] Dynamic subtest ccs0: SUCCESS (0.041s)
[515.073358] Subtest before-wait: SUCCESS (0.357s)
[515.150153] [098/133] (509s left) gem_userptr_blits (usage-restrictions)
[515.227642] Starting subtest: usage-restrictions
[515.230572] Subtest usage-restrictions: SUCCESS (0.000s)
[515.363052] [099/133] (508s left) syncobj_wait (single-wait-all-submitted)
[515.424798] Starting subtest: single-wait-all-submitted
[515.527121] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[515.608572] [100/133] (508s left) kms_flip (modeset-vs-vblank-race)
[515.704076] Starting subtest: modeset-vs-vblank-race
[515.706845] Starting dynamic subtest: A-eDP1
[520.377075] Dynamic subtest A-eDP1: SUCCESS (4.672s)
[520.388752] Starting dynamic subtest: B-eDP1
[525.122095] Dynamic subtest B-eDP1: SUCCESS (4.743s)
[525.131995] Starting dynamic subtest: C-eDP1
[529.838316] Dynamic subtest C-eDP1: SUCCESS (4.713s)
[529.848523] Starting dynamic subtest: D-eDP1
[534.469237] Dynamic subtest D-eDP1: SUCCESS (4.630s)
[534.474997] Subtest modeset-vs-vblank-race: SUCCESS (18.770s)
[535.636715] [101/133] (488s left) gem_exec_schedule (semaphore-codependency)
[535.715976] Starting subtest: semaphore-codependency
[535.721693] Subtest semaphore-codependency: SUCCESS (0.015s)
[536.066928] [102/133] (488s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[536.123035] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[536.127840] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[536.307364] [103/133] (488s left) syncobj_wait (wait-for-submit-delayed-submit)
[536.375856] Starting subtest: wait-for-submit-delayed-submit
[536.477556] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[536.560498] [104/133] (487s left) syncobj_timeline (device-signal-unordered)
[536.618183] Starting subtest: device-signal-unordered
[536.620575] Subtest device-signal-unordered: SUCCESS (0.000s)
[536.699447] [105/133] (487s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[536.801832] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[536.804164] Starting dynamic subtest: pipe-A-eDP-1
[536.901357] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[536.914118] Starting dynamic subtest: pipe-B-eDP-1
[538.015714] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s)
[538.021526] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.215s)
[539.194221] [106/133] (485s left) gem_fenced_exec_thrash (no-spare-fences)
[539.262666] Subtest no-spare-fences: SKIP (0.000s)
[539.334152] [107/133] (485s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[539.421741] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[539.426242] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[539.512247] [108/133] (485s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[539.566260] Starting subtest: y-tiled-to-vebox-y-tiled
[539.571156] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[539.760770] [109/133] (484s left) syncobj_timeline (multi-wait-signaled)
[539.820385] Starting subtest: multi-wait-signaled
[539.823162] Subtest multi-wait-signaled: SUCCESS (0.000s)
[539.919867] [110/133] (484s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[540.018610] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[540.021168] Starting dynamic subtest: pipe-A-default-mode
[541.159312] Dynamic subtest pipe-A-default-mode: SKIP (1.139s)
[541.164236] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.141s)
[541.314901] [111/133] (483s left) gem_exec_balancer (nohangcheck)
[541.570079] Starting subtest: nohangcheck
[542.437150] Subtest nohangcheck: SUCCESS (0.867s)
[542.545381] [112/133] (482s left) kms_pm_rpm (modeset-lpsp-stress)
[544.287822] Starting subtest: modeset-lpsp-stress
[559.583843] Subtest modeset-lpsp-stress: SUCCESS (15.297s)
[559.673644] [113/133] (465s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[559.783534] Starting subtest: x-tiled-64bpp-rotate-270
[559.803366] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[559.917538] [114/133] (464s left) kms_invalid_mode (uint-max-clock)
[560.007499] Starting subtest: uint-max-clock
[560.009715] Starting dynamic subtest: pipe-A-eDP-1
[560.288840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[560.299542] Starting dynamic subtest: pipe-B-eDP-1
[560.301865] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[560.310756] Starting dynamic subtest: pipe-C-eDP-1
[560.313765] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[560.323124] Starting dynamic subtest: pipe-D-eDP-1
[560.325878] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[560.328649] Subtest uint-max-clock: SUCCESS (0.288s)
[561.167659] [115/133] (463s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[561.257106] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[561.259520] Starting dynamic subtest: pipe-A-eDP-1
[561.280235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[561.290614] Starting dynamic subtest: pipe-B-eDP-1
[561.312738] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[561.321622] Starting dynamic subtest: pipe-C-eDP-1
[561.344020] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[561.353037] Starting dynamic subtest: pipe-D-eDP-1
[561.375688] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[561.378209] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[563.542629] [116/133] (461s left) sysfs_timeslice_duration (duration)
[563.598327] Starting subtest: duration
[563.600701] Starting dynamic subtest: vecs0
[577.057130] Dynamic subtest vecs0: SUCCESS (13.458s)
[577.070323] Starting dynamic subtest: ccs0
[590.213399] Dynamic subtest ccs0: SUCCESS (13.154s)
[590.225873] Starting dynamic subtest: vcs0
[604.064590] Dynamic subtest vcs0: SUCCESS (13.847s)
[604.077369] Starting dynamic subtest: bcs0
[617.213666] Dynamic subtest bcs0: SUCCESS (13.147s)
[617.233473] Starting dynamic subtest: rcs0
[630.362511] Dynamic subtest rcs0: SUCCESS (13.146s)
[630.374819] Starting dynamic subtest: vcs1
[644.064243] Dynamic subtest vcs1: SUCCESS (13.698s)
[644.067180] Subtest duration: SUCCESS (80.467s)
[644.154686] [117/133] (380s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[644.256406] Starting subtest: stress-xrgb8888-xtiled
[650.035711] Subtest stress-xrgb8888-xtiled: SUCCESS (5.782s)
[650.093288] [118/133] (374s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[650.214445] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[651.600684] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.387s)
[652.396178] [119/133] (372s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[652.500484] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[653.391436] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.893s)
[653.551895] [120/133] (371s left) gem_lmem_swapping (parallel-random-verify-ccs)
[653.597537] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[653.655255] [121/133] (371s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[653.748835] Starting subtest: yf-tiled-64bpp-rotate-0
[653.754622] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[653.854509] [122/133] (371s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[653.941434] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[660.655816] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.718s)
[660.768381] [123/133] (364s left) i915_pciid
[660.942126] [124/133] (364s left) kms_dsc (dsc-with-bpc-formats)
[661.044876] Starting subtest: dsc-with-bpc-formats
[661.172548] Subtest dsc-with-bpc-formats: SKIP (0.002s)
[661.211108] [125/133] (364s left) gem_ctx_isolation (nonpriv)
[661.262510] Starting subtest: nonpriv
[661.265346] Starting dynamic subtest: rcs0
[661.503803] Dynamic subtest rcs0: SUCCESS (0.241s)
[661.516930] Starting dynamic subtest: bcs0
[661.770136] Dynamic subtest bcs0: SUCCESS (0.266s)
[661.782238] Starting dynamic subtest: vcs0
[662.044551] Dynamic subtest vcs0: SUCCESS (0.274s)
[662.056407] Starting dynamic subtest: vcs1
[663.333877] Dynamic subtest vcs1: SUCCESS (1.287s)
[663.346013] Starting dynamic subtest: vecs0
[665.359056] Dynamic subtest vecs0: SUCCESS (2.024s)
[665.369600] Starting dynamic subtest: ccs0
[667.417378] Dynamic subtest ccs0: SUCCESS (2.057s)
[667.420474] Subtest nonpriv: SUCCESS (6.155s)
[667.647787] [126/133] (357s left) kms_prop_blob (invalid-set-prop-any)
[667.705802] Starting subtest: invalid-set-prop-any
[667.708193] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[667.802920] [127/133] (357s left) syncobj_wait (reset-signaled)
[667.855748] Starting subtest: reset-signaled
[667.858710] Subtest reset-signaled: SUCCESS (0.000s)
[667.966517] [128/133] (357s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[668.065866] Starting subtest: y-tiled-8bpp-rotate-0
[668.071024] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[668.155422] [129/133] (357s left) kms_psr (psr2-primary-render)
[668.248726] Starting subtest: psr2-primary-render
[668.251161] Starting dynamic subtest: eDP-1
[670.026130] Dynamic subtest eDP-1: SUCCESS (1.775s)
[670.028342] Subtest psr2-primary-render: SUCCESS (1.776s)
[670.912263] [130/133] (354s left) gem_busy (extended)
[671.099206] Starting subtest: extended
[671.101941] Starting dynamic subtest: rcs0
[671.193501] Dynamic subtest rcs0: SUCCESS (0.094s)
[671.205527] Starting dynamic subtest: bcs0
[671.237190] Dynamic subtest bcs0: SUCCESS (0.041s)
[671.247800] Starting dynamic subtest: vcs0
[673.154933] Dynamic subtest vcs0: SUCCESS (1.914s)
[673.168728] Starting dynamic subtest: vcs1
[675.138455] Dynamic subtest vcs1: SUCCESS (1.980s)
[675.151862] Starting dynamic subtest: vecs0
[677.122839] Dynamic subtest vecs0: SUCCESS (1.982s)
[677.135823] Starting dynamic subtest: ccs0
[677.169337] Dynamic subtest ccs0: SUCCESS (0.045s)
[677.172162] Subtest extended: SUCCESS (6.071s)
[677.374555] [131/133] (348s left) i915_pm_rpm (system-suspend-execbuf)
[679.320728] Starting subtest: system-suspend-execbuf
[737.595812] Subtest system-suspend-execbuf: SUCCESS (42.927s)
[737.965344] [132/133] (287s left) gem_ctx_persistence (heartbeat-hang)
[738.017122] Starting subtest: heartbeat-hang
[738.021786] Subtest heartbeat-hang: SKIP (0.000s)
[738.119529] [133/133] (287s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[738.232011] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[738.236413] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[738.337620] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: device_reset
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_lease
results: parsing output: 11/ for test: gem_workarounds
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_lmem_swapping
results: parsing output: 14/ for test: i915_query
results: parsing output: 15/ for test: api_intel_bb
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: drm_read
results: parsing output: 21/ for test: i915_pm_sseu
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_chamelium_edid
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_content_protection
results: parsing output: 26/ for test: kms_sequence
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: gem_ctx_shared
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: kms_atomic
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: kms_cursor_edge_walk
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: kms_rotation_crc
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_atomic_transition
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_whisper
results: parsing output: 48/ for test: kms_flip_scaled_crc
results: parsing output: 49/ for test: intel_hwmon
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: prime_mmap
results: parsing output: 53/ for test: gem_fenced_exec_thrash
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_flip_tiling
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: sw_sync
results: parsing output: 69/ for test: kms_debugfs
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: prime_vgem
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: api_intel_allocator
results: parsing output: 76/ for test: gem_exec_params
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_wait
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_basic
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: gem_sync
results: parsing output: 88/ for test: kms_properties
results: parsing output: 89/ for test: gem_ctx_exec
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: gem_eio
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: prime_busy
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_fenced_exec_thrash
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_invalid_mode
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: sysfs_timeslice_duration
results: parsing output: 116/ for test: kms_pipe_stress
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_lmem_swapping
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: i915_pciid
results: parsing output: 123/ for test: kms_dsc
results: parsing output: 124/ for test: gem_ctx_isolation
results: parsing output: 125/ for test: kms_prop_blob
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_busy
results: parsing output: 130/ for test: i915_pm_rpm
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.