[63.728769] Initializing watchdogs
[63.728812]   /dev/watchdog0
[63.743024] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[63.747074] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.749083] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.752506] [001/133] (960s left) gem_mmap_wc (write-gtt-read-wc)
[63.828326] Subtest write-gtt-read-wc: SKIP (0.000s)
[63.880795] [002/133] (960s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[64.011671] Starting subtest: dp-mst-type-1-suspend-resume
[64.016230] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[64.115168] [003/133] (960s left) kms_big_fb (y-tiled-addfb-size-overflow)
[64.204645] Starting subtest: y-tiled-addfb-size-overflow
[64.209025] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[64.286958] [004/133] (960s left) gem_exec_params (invalid-ring2)
[64.357836] Starting subtest: invalid-ring2
[64.360170] Subtest invalid-ring2: SUCCESS (0.000s)
[64.448904] [005/133] (959s left) gem_ctx_shared (q-smoketest)
[64.506276] Starting subtest: Q-smoketest
[64.508561] Starting dynamic subtest: rcs0
[70.060261] Dynamic subtest rcs0: SUCCESS (5.500s)
[70.070327] Starting dynamic subtest: bcs0
[75.542781] Dynamic subtest bcs0: SUCCESS (5.488s)
[75.552324] Starting dynamic subtest: vcs0
[81.018322] Dynamic subtest vcs0: SUCCESS (5.473s)
[81.027108] Starting dynamic subtest: vcs1
[86.495341] Dynamic subtest vcs1: SUCCESS (5.478s)
[86.502384] Starting dynamic subtest: vecs0
[91.992072] Dynamic subtest vecs0: SUCCESS (5.490s)
[91.999984] Starting dynamic subtest: ccs0
[97.494787] Dynamic subtest ccs0: SUCCESS (5.503s)
[97.496842] Subtest Q-smoketest: SUCCESS (32.934s)
[97.633049] [006/133] (926s left) gem_ctx_persistence (engines-cleanup)
[97.697037] Starting subtest: engines-cleanup
[97.699496] Starting dynamic subtest: rcs0
[97.767863] Dynamic subtest rcs0: SUCCESS (0.071s)
[97.777652] Starting dynamic subtest: bcs0
[97.807715] Dynamic subtest bcs0: SUCCESS (0.039s)
[97.816650] Starting dynamic subtest: vcs0
[97.843612] Dynamic subtest vcs0: SUCCESS (0.036s)
[97.852224] Starting dynamic subtest: vcs1
[97.882614] Dynamic subtest vcs1: SUCCESS (0.038s)
[97.892543] Starting dynamic subtest: vecs0
[97.921672] Dynamic subtest vecs0: SUCCESS (0.039s)
[97.929785] Starting dynamic subtest: ccs0
[97.969808] Dynamic subtest ccs0: SUCCESS (0.047s)
[97.972327] Subtest engines-cleanup: SUCCESS (0.273s)
[98.045430] [007/133] (926s left) kms_addfb_basic (bad-pitch-128)
[98.106687] Starting subtest: bad-pitch-128
[98.109251] Subtest bad-pitch-128: SUCCESS (0.000s)
[98.221398] [008/133] (926s left) kms_psr (psr2-primary-mmap-cpu)
[98.290614] Starting subtest: psr2-primary-mmap-cpu
[98.292766] Starting dynamic subtest: eDP-1
[100.011837] Dynamic subtest eDP-1: SUCCESS (1.720s)
[100.014198] Subtest psr2-primary-mmap-cpu: SUCCESS (1.721s)
[100.872931] [009/133] (923s left) kms_psr (fbc-pr-cursor-plane-move)
[100.950819] Starting subtest: fbc-pr-cursor-plane-move
[100.954784] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[101.028790] [010/133] (923s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[101.097853] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[101.102268] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[101.168837] [011/133] (923s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[101.242060] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[101.246616] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[101.308713] [012/133] (923s left) gem_spin_batch (legacy)
[101.372685] Starting subtest: legacy
[101.375144] Starting dynamic subtest: default
[104.613284] Dynamic subtest default: SUCCESS (3.235s)
[104.623329] Starting dynamic subtest: render
[107.847747] Dynamic subtest render: SUCCESS (3.233s)
[107.856215] Starting dynamic subtest: bsd
[111.085704] Dynamic subtest bsd: SUCCESS (3.235s)
[111.093881] Starting dynamic subtest: bsd1
[114.318807] Dynamic subtest bsd1: SUCCESS (3.232s)
[114.326951] Starting dynamic subtest: bsd2
[117.554597] Dynamic subtest bsd2: SUCCESS (3.233s)
[117.563118] Starting dynamic subtest: blt
[120.792145] Dynamic subtest blt: SUCCESS (3.235s)
[120.801979] Starting dynamic subtest: vebox
[124.029251] Dynamic subtest vebox: SUCCESS (3.234s)
[124.031376] Subtest legacy: SUCCESS (22.651s)
[124.911601] [013/133] (899s left) vgem_basic (bad-fence)
[125.023849] Starting subtest: bad-fence
[125.025908] Subtest bad-fence: SUCCESS (0.000s)
[125.077849] [FACT vgem_basic (bad-fence)] new: kernel.kmod_is_loaded.vgem: true
[125.080781] [014/133] (899s left) kms_3d (basic)
[125.123774] Starting subtest: basic
[125.128200] Subtest basic: SKIP (0.000s)
[125.223251] [015/133] (899s left) gem_linear_blits (normal)
[125.583612] Starting subtest: normal
[130.183967] Subtest normal: SUCCESS (4.599s)
[130.373425] [016/133] (894s left) kms_hdr (bpc-switch-dpms)
[130.485626] Starting subtest: bpc-switch-dpms
[131.538655] Starting dynamic subtest: pipe-A-eDP-1
[135.944804] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.406s)
[135.947120] Subtest bpc-switch-dpms: SUCCESS (5.460s)
[136.045538] [017/133] (888s left) prime_busy (hang-wait)
[136.122878] Starting subtest: hang-wait
[136.125334] Starting dynamic subtest: rcs0
[162.300917] Dynamic subtest rcs0: SUCCESS (26.175s)
[162.310499] Starting dynamic subtest: bcs0
[169.532072] Dynamic subtest bcs0: SUCCESS (7.228s)
[169.541828] Starting dynamic subtest: vcs0
[176.487810] Dynamic subtest vcs0: SUCCESS (6.954s)
[176.495201] Starting dynamic subtest: vcs1
[183.529116] Dynamic subtest vcs1: SUCCESS (7.040s)
[183.536072] Starting dynamic subtest: vecs0
[190.504407] Dynamic subtest vecs0: SUCCESS (6.974s)
[190.517858] Starting dynamic subtest: ccs0
[204.350481] Dynamic subtest ccs0: SUCCESS (13.844s)
[204.352537] Subtest hang-wait: SUCCESS (68.223s)
[204.479964] [018/133] (820s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[204.562981] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[204.565406] Starting dynamic subtest: pipe-A-eDP-1
[204.589496] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[204.597720] Starting dynamic subtest: pipe-B-eDP-1
[204.618077] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[204.627734] Starting dynamic subtest: pipe-C-eDP-1
[204.655146] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[204.662384] Starting dynamic subtest: pipe-D-eDP-1
[204.683349] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[204.687718] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[206.774063] [019/133] (818s left) gem_exec_flush (basic-uc-prw-default)
[206.836519] Starting subtest: basic-uc-prw-default
[212.300481] Subtest basic-uc-prw-default: SUCCESS (5.465s)
[212.502380] [020/133] (812s left) perf (invalid-oa-format-id)
[212.639338] Starting subtest: invalid-oa-format-id
[212.651932] Subtest invalid-oa-format-id: SUCCESS (0.012s)
[212.688769] [021/133] (812s left) gem_flink_basic (flink-lifetime)
[212.758132] Starting subtest: flink-lifetime
[212.763015] Subtest flink-lifetime: SUCCESS (0.004s)
[212.853290] [022/133] (812s left) perf_pmu (faulting-read)
[212.892600] Starting subtest: faulting-read
[212.895053] Starting dynamic subtest: wb
[212.897431] Dynamic subtest wb: SUCCESS (0.001s)
[212.906846] Starting dynamic subtest: wc
[212.908761] Dynamic subtest wc: SUCCESS (0.000s)
[212.916606] Starting dynamic subtest: uc
[212.918834] Dynamic subtest uc: SUCCESS (0.000s)
[212.921160] Subtest faulting-read: SUCCESS (0.002s)
[212.988756] [023/133] (812s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[213.053389] Starting subtest: bad-rotation-90-yf-tiled-ccs
[213.055786] Starting dynamic subtest: pipe-A-eDP-1
[213.079195] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[213.089950] Starting dynamic subtest: pipe-B-eDP-1
[213.111868] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[213.119243] Starting dynamic subtest: pipe-C-eDP-1
[213.141128] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[213.148827] Starting dynamic subtest: pipe-D-eDP-1
[213.171779] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[213.176236] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.003s)
[215.354116] [024/133] (809s left) gem_ccs (block-multicopy-inplace)
[215.417778] Starting subtest: block-multicopy-inplace
[215.422140] Subtest block-multicopy-inplace: SKIP (0.000s)
[215.535127] [025/133] (809s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[215.626917] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[215.631409] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[215.722705] [026/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[215.810951] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[215.815168] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[215.903632] [027/133] (809s left) i915_pm_rps (thresholds-idle)
[215.963630] Starting subtest: thresholds-idle
[215.968123] Subtest thresholds-idle: SKIP (0.001s)
[216.060707] [028/133] (809s left) kms_vrr (negative-basic)
[216.152158] Starting subtest: negative-basic
[216.159074] Starting dynamic subtest: pipe-A-eDP-1
[221.572496] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[221.850800] Subtest negative-basic: SUCCESS (5.700s)
[222.671691] [029/133] (802s left) syncobj_basic (bad-handle-to-fd)
[222.737505] Starting subtest: bad-handle-to-fd
[222.739961] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[222.849327] [030/133] (802s left) kms_plane_cursor (primary)
[222.918946] Starting subtest: primary
[222.923303] Starting dynamic subtest: pipe-A-eDP-1-size-64
[225.533226] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.617s)
[225.558885] Starting dynamic subtest: pipe-A-eDP-1-size-128
[228.101568] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[228.125099] Starting dynamic subtest: pipe-A-eDP-1-size-256
[230.691289] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[231.023885] Starting dynamic subtest: pipe-B-eDP-1-size-64
[234.243307] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.237s)
[234.268463] Starting dynamic subtest: pipe-B-eDP-1-size-128
[236.832312] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.573s)
[236.857052] Starting dynamic subtest: pipe-B-eDP-1-size-256
[239.411076] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s)
[239.731159] Starting dynamic subtest: pipe-C-eDP-1-size-64
[242.594790] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.875s)
[242.619893] Starting dynamic subtest: pipe-C-eDP-1-size-128
[244.882855] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.269s)
[244.908408] Starting dynamic subtest: pipe-C-eDP-1-size-256
[247.117441] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[247.434594] Starting dynamic subtest: pipe-D-eDP-1-size-64
[250.375992] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.951s)
[250.402060] Starting dynamic subtest: pipe-D-eDP-1-size-128
[252.566697] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.169s)
[252.591608] Starting dynamic subtest: pipe-D-eDP-1-size-256
[254.764839] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[255.078354] Subtest primary: SUCCESS (32.160s)
[255.877473] [031/133] (769s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[255.962315] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[260.455219] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.496s)
[261.584208] [032/133] (763s left) gem_exec_balancer (waits)
[261.641390] Starting subtest: waits
[268.147258] Subtest waits: SUCCESS (6.507s)
[268.453285] [033/133] (757s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[268.582100] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[268.586803] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[268.736593] [034/133] (756s left) gem_render_copy_redux (flink)
[268.799637] Starting subtest: flink
[269.580235] Subtest flink: SUCCESS (0.781s)
[269.724774] [035/133] (755s left) gem_exec_params (mmapped)
[269.774487] Starting subtest: mmapped
[269.779042] Subtest mmapped: SUCCESS (0.003s)
[269.881461] [036/133] (755s left) gem_mmap_gtt (cpuset-big-copy-xy)
[269.946445] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[270.011925] [037/133] (755s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[270.063973] Starting subtest: etime-single-wait-available-unsubmitted
[270.164085] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s)
[270.240063] [038/133] (755s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[270.604566] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[271.383936] [039/133] (754s left) kms_cursor_edge_walk (64x64-left-edge)
[271.457923] Starting subtest: 64x64-left-edge
[271.460106] Starting dynamic subtest: pipe-A-eDP-1
[274.908043] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[274.916824] Starting dynamic subtest: pipe-D-eDP-1
[278.123276] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.216s)
[278.125586] Subtest 64x64-left-edge: SUCCESS (6.667s)
[278.921715] [040/133] (746s left) kms_selftest (drm_format_helper)
[278.963182] Starting subtest: drm_format_helper
[279.023462] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[279.101304] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.076s)
[279.111169] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[279.193450] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.090s)
[279.203564] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[279.281535] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.088s)
[279.292055] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[279.363429] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.081s)
[279.372363] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[279.459254] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.094s)
[279.468836] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[279.549668] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.089s)
[279.559892] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[279.668245] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.116s)
[279.678047] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[279.758097] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.091s)
[279.768040] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[279.848450] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.087s)
[279.857662] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[279.945060] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.099s)
[279.954861] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[280.060798] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.113s)
[280.068789] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[280.147626] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.085s)
[280.155114] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[280.250743] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.102s)
[280.258556] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[280.351742] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.097s)
[280.360612] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[280.451644] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.099s)
[280.460624] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[280.551598] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.100s)
[280.561150] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[280.646718] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.093s)
[280.648938] Subtest drm_format_helper: SUCCESS (1.682s)
[280.791536] [041/133] (744s left) gem_userptr_blits (stress-purge)
[280.854612] Starting subtest: stress-purge
[286.231694] Subtest stress-purge: SUCCESS (5.380s)
[286.362188] [042/133] (739s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[286.469931] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[293.504960] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.035s)
[293.614677] [043/133] (732s left) kms_feature_discovery (display-2x)
[293.690827] Starting subtest: display-2x
[293.695341] Subtest display-2x: SKIP (0.000s)
[293.763140] [044/133] (732s left) gem_ctx_persistence (many-contexts)
[293.816848] Starting subtest: many-contexts
[331.485260] Subtest many-contexts: SUCCESS (37.666s)
[331.563479] [045/133] (694s left) gem_exec_reloc (basic-wc-gtt)
[331.616589] Subtest basic-wc-gtt: SKIP (0.000s)
[331.687337] [046/133] (694s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[331.767872] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[331.770589] Starting dynamic subtest: pipe-A
[331.787367] Dynamic subtest pipe-A: SKIP (0.017s)
[331.800500] Starting dynamic subtest: pipe-B
[331.818768] Dynamic subtest pipe-B: SKIP (0.030s)
[331.827383] Starting dynamic subtest: pipe-C
[331.851996] Dynamic subtest pipe-C: SKIP (0.031s)
[331.860486] Starting dynamic subtest: pipe-D
[331.881194] Dynamic subtest pipe-D: SKIP (0.030s)
[331.884950] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.110s)
[332.022480] [047/133] (694s left) kms_big_fb (x-tiled-addfb)
[332.099587] Starting subtest: x-tiled-addfb
[332.101978] Subtest x-tiled-addfb: SUCCESS (0.000s)
[332.196944] [048/133] (693s left) gen7_exec_parse (bitmasks)
[332.258058] Subtest bitmasks: SKIP (0.000s)
[332.325931] [049/133] (693s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[332.395877] Starting subtest: fbc-psr-cursor-mmap-gtt
[332.398255] Starting dynamic subtest: eDP-1
[332.402611] Dynamic subtest eDP-1: SKIP (0.000s)
[332.407062] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[332.469689] [050/133] (693s left) kms_properties (connector-properties-legacy)
[332.530612] Starting subtest: connector-properties-legacy
[332.532697] Starting dynamic subtest: pipe-A-eDP-1
[340.440322] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.906s)
[340.449807] Starting dynamic subtest: pipe-None-DP-1
[340.453893] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[340.461654] Starting dynamic subtest: pipe-None-DP-2
[340.465796] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[340.473760] Starting dynamic subtest: pipe-None-DP-3
[340.478606] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[340.487053] Starting dynamic subtest: pipe-None-DP-4
[340.491646] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[340.500226] Starting dynamic subtest: pipe-None-DP-5
[340.504816] Dynamic subtest pipe-None-DP-5: SUCCESS (0.001s)
[340.506805] Subtest connector-properties-legacy: SUCCESS (7.915s)
[341.323693] [051/133] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[341.404886] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[348.110780] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.711s)
[348.236982] [052/133] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[348.322955] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[348.327354] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[348.418677] [053/133] (677s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[348.495303] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[355.216445] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.723s)
[355.341131] [054/133] (671s left) kms_flip (flip-vs-panning-interruptible)
[355.412573] Starting subtest: flip-vs-panning-interruptible
[355.414892] Starting dynamic subtest: A-eDP1
[364.155966] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[364.169548] Starting dynamic subtest: B-eDP1
[372.877931] Dynamic subtest B-eDP1: SUCCESS (8.719s)
[372.889023] Starting dynamic subtest: C-eDP1
[381.598212] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[381.607517] Starting dynamic subtest: D-eDP1
[390.324113] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[390.330076] Subtest flip-vs-panning-interruptible: SUCCESS (34.916s)
[391.485713] [055/133] (634s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[391.553390] Starting subtest: yf-tiled-ccs-to-y-tiled
[391.558169] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[391.736854] [056/133] (634s left) kms_flip (2x-flip-vs-panning-interruptible)
[391.832739] Starting subtest: 2x-flip-vs-panning-interruptible
[391.850668] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.017s)
[391.933180] [057/133] (634s left) syncobj_timeline (single-wait-signaled)
[392.008340] Starting subtest: single-wait-signaled
[392.010765] Subtest single-wait-signaled: SUCCESS (0.001s)
[392.098477] [058/133] (634s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[392.168139] Starting subtest: fbc-rgb565-draw-pwrite
[396.754645] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.588s)
[397.885577] [059/133] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[397.971266] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[397.975512] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[398.075961] [060/133] (628s left) gem_exec_fence (syncobj-channel)
[398.510231] Starting subtest: syncobj-channel
[399.527068] Subtest syncobj-channel: SUCCESS (1.014s)
[399.916280] [061/133] (626s left) gem_mmap_offset (oob-read)
[399.971377] Starting subtest: oob-read
[399.973448] Subtest oob-read: SUCCESS (0.000s)
[400.067865] [062/133] (626s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[400.141802] Starting subtest: disable-crc-after-crtc
[400.143769] Starting dynamic subtest: pipe-A-eDP-1
[401.812536] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.669s)
[401.822087] Starting dynamic subtest: pipe-B-eDP-1
[404.168909] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.355s)
[404.178461] Starting dynamic subtest: pipe-C-eDP-1
[406.407261] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.237s)
[406.416109] Starting dynamic subtest: pipe-D-eDP-1
[408.677124] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.268s)
[408.679440] Subtest disable-crc-after-crtc: SUCCESS (8.535s)
[409.496137] [063/133] (617s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[409.556839] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[409.559123] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[409.642392] [064/133] (617s left) gem_userptr_blits (sync-unmap-after-close)
[409.724156] Starting subtest: sync-unmap-after-close
[409.735385] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[409.852141] [065/133] (616s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[409.932268] Starting subtest: pr-plane-move-sf-dmg-area
[409.936474] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[410.000015] [066/133] (616s left) api_intel_allocator (execbuf-with-allocator)
[410.058588] Starting subtest: execbuf-with-allocator
[410.062277] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[410.176906] [067/133] (616s left) kms_chamelium_hpd (hdmi-hpd-storm)
[410.535122] Subtest hdmi-hpd-storm: SKIP (0.000s)
[411.302247] [068/133] (615s left) api_intel_bb (reset-bb)
[411.361347] Starting subtest: reset-bb
[411.363268] Subtest reset-bb: SUCCESS (0.004s)
[411.486877] [069/133] (615s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[411.592460] Starting subtest: cursorA-vs-flipA-toggle
[422.709758] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.117s)
[423.558470] [070/133] (603s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[423.678555] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[423.683445] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[423.792789] [071/133] (603s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[423.871839] Starting subtest: primary-4-tiled-reflect-x-0
[430.840780] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.970s)
[432.021862] [072/133] (595s left) kms_rotation_crc (sprite-rotation-180)
[432.092354] Starting subtest: sprite-rotation-180
[438.895967] Subtest sprite-rotation-180: SUCCESS (6.804s)
[440.078259] [073/133] (587s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[440.166891] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[444.048278] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.885s)
[445.183497] [074/133] (581s left) gem_eio (in-flight-1us)
[445.428961] Starting subtest: in-flight-1us
[453.661598] Subtest in-flight-1us: SUCCESS (8.232s)
[453.811346] [075/133] (573s left) gem_ctx_param (root-set)
[453.866762] Starting subtest: root-set
[453.869057] Subtest root-set: SUCCESS (0.001s)
[453.978683] [076/133] (573s left) dmabuf_sync_file (export-multiwait)
[454.020269] Starting subtest: export-multiwait
[454.022130] Subtest export-multiwait: SUCCESS (0.000s)
[454.075773] [077/133] (573s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[454.157486] Starting subtest: fbc-psr2-cursor-mmap-cpu
[454.159392] Starting dynamic subtest: eDP-1
[454.163411] Dynamic subtest eDP-1: SKIP (0.000s)
[454.167466] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[454.244394] [078/133] (573s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[454.301650] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[454.303621] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[454.394882] [079/133] (572s left) gem_softpin (noreloc-interruptible)
[454.456232] Starting subtest: noreloc-interruptible
[459.871800] Subtest noreloc-interruptible: SUCCESS (5.413s)
[460.021619] [080/133] (567s left) gem_eio (wait-wedge-10ms)
[460.258022] Starting subtest: wait-wedge-10ms
[461.945500] Subtest wait-wedge-10ms: SUCCESS (1.687s)
[462.069390] [081/133] (565s left) gem_pxp (reject-modify-context-protection-off-2)
[462.180232] Starting subtest: reject-modify-context-protection-off-2
[462.182828] Subtest reject-modify-context-protection-off-2: SUCCESS (0.001s)
[462.282261] [082/133] (565s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[462.373117] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[462.377387] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[462.469611] [083/133] (565s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[462.541512] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[462.543828] Starting dynamic subtest: pipe-A
[463.668990] Dynamic subtest pipe-A: SUCCESS (1.129s)
[463.679664] Starting dynamic subtest: pipe-B
[465.827479] Dynamic subtest pipe-B: SUCCESS (2.157s)
[465.835910] Starting dynamic subtest: pipe-C
[466.979089] Dynamic subtest pipe-C: SUCCESS (1.150s)
[466.988890] Starting dynamic subtest: pipe-D
[468.206865] Dynamic subtest pipe-D: SUCCESS (1.227s)
[468.209220] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.667s)
[469.407765] [084/133] (558s left) gem_ctx_param (invalid-param-set)
[469.461628] Starting subtest: invalid-param-set
[469.463996] Subtest invalid-param-set: SUCCESS (0.000s)
[469.549844] [085/133] (558s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[469.635680] Starting subtest: yf-tiled-16bpp-rotate-90
[469.640187] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[469.727885] [086/133] (557s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[469.806034] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[469.809666] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[469.889320] [087/133] (557s left) kms_pm_rpm (universal-planes)
[471.990562] Starting subtest: universal-planes
[471.993190] Starting dynamic subtest: plane-34
[480.281680] Dynamic subtest plane-34: SUCCESS (8.294s)
[480.292784] Starting dynamic subtest: plane-64
[488.581501] Dynamic subtest plane-64: SUCCESS (8.297s)
[488.596042] Starting dynamic subtest: plane-94
[496.883285] Dynamic subtest plane-94: SUCCESS (8.298s)
[496.893578] Starting dynamic subtest: plane-124
[505.172579] Dynamic subtest plane-124: SUCCESS (8.286s)
[505.181600] Starting dynamic subtest: plane-134
[513.439945] Dynamic subtest plane-134: SUCCESS (8.265s)
[513.451786] Starting dynamic subtest: plane-144
[521.714428] Dynamic subtest plane-144: SUCCESS (8.271s)
[521.717326] Subtest universal-planes: SUCCESS (49.728s)
[522.088314] [088/133] (505s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[522.184514] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[522.189215] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[522.304830] [089/133] (505s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[522.381625] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[522.383827] Starting dynamic subtest: pipe-A-eDP-1
[522.440232] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[522.455044] Starting dynamic subtest: pipe-B-eDP-1
[522.513223] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[522.523904] Starting dynamic subtest: pipe-C-eDP-1
[522.580608] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[522.589654] Starting dynamic subtest: pipe-D-eDP-1
[522.644644] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[522.649098] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.010s)
[524.636284] [090/133] (503s left) i915_hangman (gt-engine-error)
[524.705740] Starting subtest: gt-engine-error
[524.707674] Starting dynamic subtest: rcs0
[525.815124] Dynamic subtest rcs0: SUCCESS (1.109s)
[525.827748] Starting dynamic subtest: bcs0
[527.799690] Dynamic subtest bcs0: SUCCESS (1.980s)
[527.812522] Starting dynamic subtest: vcs0
[529.783819] Dynamic subtest vcs0: SUCCESS (1.981s)
[529.795840] Starting dynamic subtest: vcs1
[531.831791] Dynamic subtest vcs1: SUCCESS (2.045s)
[531.844948] Starting dynamic subtest: vecs0
[533.816048] Dynamic subtest vecs0: SUCCESS (1.982s)
[533.828361] Starting dynamic subtest: ccs0
[535.799946] Dynamic subtest ccs0: SUCCESS (1.981s)
[535.803245] Subtest gt-engine-error: SUCCESS (11.095s)
[535.939445] [091/133] (491s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[536.026765] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[536.030795] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[536.121234] [092/133] (491s left) gem_workarounds (suspend-resume-fd)
[536.199034] Starting subtest: suspend-resume-fd
[551.977684] Subtest suspend-resume-fd: SUCCESS (2.049s)
[552.116126] [093/133] (475s left) kms_lease (setcrtc-implicit-plane)
[552.213721] Starting subtest: setcrtc-implicit-plane
[552.216066] Starting dynamic subtest: pipe-A-eDP-1
[552.681796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[552.692515] Starting dynamic subtest: pipe-B-eDP-1
[553.885731] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.192s)
[553.895673] Starting dynamic subtest: pipe-C-eDP-1
[555.012922] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[555.026723] Starting dynamic subtest: pipe-D-eDP-1
[556.151182] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[556.153378] Subtest setcrtc-implicit-plane: SUCCESS (3.911s)
[556.997921] [094/133] (470s left) gem_pread (self)
[557.058754] Subtest self: SKIP (0.000s)
[557.119944] [095/133] (470s left) kms_pm_rpm (dpms-non-lpsp)
[558.732627] Starting subtest: dpms-non-lpsp
[558.737435] Subtest dpms-non-lpsp: SKIP (0.001s)
[559.352547] [096/133] (468s left) gem_exec_balancer (full-late)
[559.414514] Starting subtest: full-late
[564.403704] Subtest full-late: SUCCESS (4.974s)
[564.728671] [097/133] (463s left) gem_mmap_gtt (big-copy)
[564.798308] Subtest big-copy: SKIP (0.000s)
[564.866608] [098/133] (463s left) syncobj_wait (wait-delayed-signal)
[564.921080] Starting subtest: wait-delayed-signal
[565.023101] Subtest wait-delayed-signal: SUCCESS (0.102s)
[565.112544] [099/133] (463s left) kms_async_flips (test-time-stamp-atomic)
[565.188323] Starting subtest: test-time-stamp-atomic
[565.575163] Starting dynamic subtest: pipe-A-eDP-1
[566.364086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[566.738869] Starting dynamic subtest: pipe-B-eDP-1
[567.492518] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.758s)
[567.857679] Starting dynamic subtest: pipe-C-eDP-1
[568.620351] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[568.982303] Starting dynamic subtest: pipe-D-eDP-1
[569.750618] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s)
[569.753072] Subtest test-time-stamp-atomic: SUCCESS (4.555s)
[570.911686] [100/133] (457s left) i915_pm_rpm (gem-idle)
[572.715154] Starting subtest: gem-idle
[578.917086] Subtest gem-idle: SUCCESS (6.198s)
[579.271345] [101/133] (449s left) gem_ctx_engines (execute-one)
[580.583124] Starting subtest: execute-one
[583.329581] Subtest execute-one: SUCCESS (2.748s)
[583.524481] [102/133] (444s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[583.609336] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[583.611259] Starting dynamic subtest: pipe-A-eDP-1
[585.821528] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.214s)
[585.831607] Starting dynamic subtest: pipe-B-eDP-1
[588.072727] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.250s)
[588.082910] Starting dynamic subtest: pipe-C-eDP-1
[590.174614] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.101s)
[590.185216] Starting dynamic subtest: pipe-D-eDP-1
[592.330752] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.155s)
[592.332731] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.725s)
[593.488482] [103/133] (434s left) gem_exec_schedule (pi-distinct-iova)
[593.680103] Starting subtest: pi-distinct-iova
[593.682190] Starting dynamic subtest: rcs0
[593.756627] Dynamic subtest rcs0: SUCCESS (0.079s)
[593.769553] Starting dynamic subtest: vcs0
[593.812650] Dynamic subtest vcs0: SUCCESS (0.056s)
[593.824111] Starting dynamic subtest: vcs1
[593.869484] Dynamic subtest vcs1: SUCCESS (0.056s)
[593.882268] Starting dynamic subtest: vecs0
[593.927867] Dynamic subtest vecs0: SUCCESS (0.058s)
[593.940406] Starting dynamic subtest: ccs0
[593.985725] Dynamic subtest ccs0: SUCCESS (0.057s)
[593.988240] Subtest pi-distinct-iova: SUCCESS (0.310s)
[595.661216] [104/133] (432s left) gem_exec_reloc (basic-gtt-read)
[595.726829] Subtest basic-gtt-read: SKIP (0.000s)
[595.795666] [105/133] (432s left) kms_frontbuffer_tracking (fbc-suspend)
[595.874509] Starting subtest: fbc-suspend
[633.501674] Subtest fbc-suspend: SUCCESS (7.617s)
[634.718138] [106/133] (393s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[634.807366] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[641.355410] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.521s)
[641.454870] [107/133] (387s left) kms_psr (pr-cursor-render)
[641.544693] Starting subtest: pr-cursor-render
[641.549998] Subtest pr-cursor-render: SKIP (0.000s)
[641.641887] [108/133] (386s left) kms_vblank (ts-continuation-modeset)
[641.724006] Starting subtest: ts-continuation-modeset
[641.726423] Starting dynamic subtest: pipe-A-eDP-1
[643.215549] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.486s)
[643.231415] Starting dynamic subtest: pipe-D-eDP-1
[645.375535] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.155s)
[645.378787] Subtest ts-continuation-modeset: SUCCESS (3.645s)
[646.177504] [109/133] (382s left) gem_softpin (evict-snoop-interruptible)
[646.244741] Starting subtest: evict-snoop-interruptible
[646.250599] Subtest evict-snoop-interruptible: SKIP (0.000s)
[646.367486] [110/133] (382s left) gem_exec_whisper (basic-contexts-priority)
[646.423764] Starting subtest: basic-contexts-priority
[670.980411] Subtest basic-contexts-priority: SUCCESS (24.543s)
[671.162567] [111/133] (357s left) kms_cursor_crc (cursor-offscreen-512x512)
[671.434468] Starting subtest: cursor-offscreen-512x512
[671.439847] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[671.593657] [112/133] (357s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[671.674326] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[671.679022] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[671.750532] [113/133] (357s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[671.830532] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[671.835667] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[671.935547] [114/133] (356s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[672.137845] Starting subtest: cursor-rapid-movement-128x42
[672.183534] Subtest cursor-rapid-movement-128x42: SKIP (0.042s)
[672.380066] [115/133] (356s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[672.455771] Starting subtest: fbc-1p-pri-indfb-multidraw
[685.516210] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.065s)
[686.904454] [116/133] (342s left) kms_chamelium_audio (hdmi-audio-edid)
[687.272979] Subtest hdmi-audio-edid: SKIP (0.000s)
[688.104252] [117/133] (340s left) syncobj_wait (invalid-signal-illegal-handle)
[688.159043] Starting subtest: invalid-signal-illegal-handle
[688.161375] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[688.235909] [118/133] (340s left) syncobj_eventfd (timeline-wait)
[688.289721] Starting subtest: timeline-wait
[688.298198] Subtest timeline-wait: SUCCESS (0.011s)
[688.399796] [119/133] (340s left) gem_readwrite (read-bad-handle)
[688.458512] Subtest read-bad-handle: SKIP (0.000s)
[688.526164] [120/133] (340s left) gem_exec_schedule (submit-early-slice)
[688.599703] Starting subtest: submit-early-slice
[688.602293] Starting dynamic subtest: rcs0
[688.640111] Dynamic subtest rcs0: SUCCESS (0.050s)
[688.652811] Starting dynamic subtest: bcs0
[688.681783] Dynamic subtest bcs0: SUCCESS (0.041s)
[688.692782] Starting dynamic subtest: vcs0
[688.721943] Dynamic subtest vcs0: SUCCESS (0.039s)
[688.732423] Starting dynamic subtest: vcs1
[688.758616] Dynamic subtest vcs1: SUCCESS (0.036s)
[688.771354] Starting dynamic subtest: vecs0
[688.800789] Dynamic subtest vecs0: SUCCESS (0.042s)
[688.811283] Starting dynamic subtest: ccs0
[688.836208] Dynamic subtest ccs0: SUCCESS (0.035s)
[688.838794] Subtest submit-early-slice: SUCCESS (0.248s)
[690.605470] [121/133] (338s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[690.703485] Starting subtest: 4-tiled-16bpp-rotate-90
[690.723825] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[690.837873] [122/133] (338s left) kms_addfb_basic (invalid-get-prop-any)
[690.895546] Starting subtest: invalid-get-prop-any
[690.898533] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[691.004493] [123/133] (338s left) i915_drm_fdinfo (virtual-busy-hang)
[691.054524] Starting subtest: virtual-busy-hang
[691.059927] Subtest virtual-busy-hang: SKIP (0.000s)
[691.129118] [124/133] (338s left) kms_color (ctm-red-to-blue)
[691.211091] Starting subtest: ctm-red-to-blue
[691.213586] Starting dynamic subtest: pipe-A-eDP-1
[691.924718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[691.938775] Starting dynamic subtest: pipe-B-eDP-1
[693.333487] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s)
[693.345811] Starting dynamic subtest: pipe-C-eDP-1
[694.726361] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s)
[694.737053] Starting dynamic subtest: pipe-D-eDP-1
[696.047391] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s)
[696.049782] Subtest ctm-red-to-blue: SUCCESS (4.835s)
[696.858046] [125/133] (332s left) gem_huc_copy (huc-copy)
[696.916196] Starting subtest: huc-copy
[696.921594] Subtest huc-copy: SUCCESS (0.004s)
[697.034424] [126/133] (332s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[697.106439] Starting subtest: psr-shrfb-scaledprimary
[702.802725] Subtest psr-shrfb-scaledprimary: SUCCESS (5.700s)
[702.924829] [127/133] (326s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[703.004211] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[703.861796] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.859s)
[704.025253] [128/133] (325s left) i915_query (query-garbage)
[704.080591] Starting subtest: query-garbage
[704.083022] Subtest query-garbage: SUCCESS (0.000s)
[704.180667] [129/133] (325s left) kms_flip (flip-vs-suspend-interruptible)
[704.256485] Starting subtest: flip-vs-suspend-interruptible
[704.259203] Starting dynamic subtest: A-eDP1
[753.973031] Dynamic subtest A-eDP1: SUCCESS (4.615s)
[753.984417] Starting dynamic subtest: B-eDP1
[802.974835] Dynamic subtest B-eDP1: SUCCESS (4.535s)
[802.992947] Starting dynamic subtest: C-eDP1
[851.964155] Dynamic subtest C-eDP1: SUCCESS (4.563s)
[851.976795] Starting dynamic subtest: D-eDP1
[900.962018] Dynamic subtest D-eDP1: SUCCESS (4.599s)
[900.965009] Subtest flip-vs-suspend-interruptible: SUCCESS (18.320s)
[902.137890] [130/133] (127s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[902.237680] Starting subtest: basic-busy-flip-before-cursor-legacy
[902.242560] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[902.382478] [131/133] (127s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[902.468091] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[902.472899] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[902.567648] [132/133] (127s left) kms_invalid_mode (int-max-clock)
[902.635806] Starting subtest: int-max-clock
[902.638026] Starting dynamic subtest: pipe-A-eDP-1
[902.917575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[902.928669] Starting dynamic subtest: pipe-B-eDP-1
[902.930875] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[902.940864] Starting dynamic subtest: pipe-C-eDP-1
[902.943266] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[902.952729] Starting dynamic subtest: pipe-D-eDP-1
[902.955105] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[902.957471] Subtest int-max-clock: SUCCESS (0.290s)
[903.765299] [133/133] (125s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[903.842815] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[903.847956] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[903.926809] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_wc
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: gem_ctx_shared
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: vgem_basic
results: parsing output: 13/ for test: kms_3d
results: parsing output: 14/ for test: gem_linear_blits
results: parsing output: 15/ for test: kms_hdr
results: parsing output: 16/ for test: prime_busy
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_exec_flush
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: gem_flink_basic
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: gem_ccs
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: i915_pm_rps
results: parsing output: 27/ for test: kms_vrr
results: parsing output: 28/ for test: syncobj_basic
results: parsing output: 29/ for test: kms_plane_cursor
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_balancer
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: gem_render_copy_redux
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: kms_selftest
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_feature_discovery
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: gem_exec_reloc
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gen7_exec_parse
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_properties
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: gem_render_copy
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: gem_mmap_offset
results: parsing output: 61/ for test: kms_pipe_crc_basic
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: api_intel_allocator
results: parsing output: 66/ for test: kms_chamelium_hpd
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_rotation_crc
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_eio
results: parsing output: 74/ for test: gem_ctx_param
results: parsing output: 75/ for test: dmabuf_sync_file
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: gem_eio
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_pm_rpm
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: i915_hangman
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_workarounds
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: gem_pread
results: parsing output: 94/ for test: kms_pm_rpm
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_async_flips
results: parsing output: 99/ for test: i915_pm_rpm
results: parsing output: 100/ for test: gem_ctx_engines
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_exec_schedule
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_chamelium_audio
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: syncobj_eventfd
results: parsing output: 118/ for test: gem_readwrite
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_color
results: parsing output: 124/ for test: gem_huc_copy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_query
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_invalid_mode
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.