[60.410151] Initializing watchdogs [60.410200] /dev/watchdog0 [60.425009] [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] [60.429331] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.431522] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.434868] [001/133] (960s left) kms_cursor_crc (cursor-onscreen-512x512) [60.731528] Starting subtest: cursor-onscreen-512x512 [60.735920] Subtest cursor-onscreen-512x512: SKIP (0.001s) [60.901433] [002/133] (960s left) syncobj_timeline (device-signal-unordered) [60.951614] Starting subtest: device-signal-unordered [60.953872] Subtest device-signal-unordered: SUCCESS (0.001s) [61.051202] [003/133] (959s left) kms_pm_rpm (basic-pci-d3-state) [63.099333] Starting subtest: basic-pci-d3-state [64.564425] Subtest basic-pci-d3-state: SUCCESS (1.471s) [64.648740] [004/133] (956s left) kms_chamelium_hpd (vga-hpd-without-ddc) [65.056401] Subtest vga-hpd-without-ddc: SKIP (0.000s) [65.835048] [005/133] (955s left) kms_flip (2x-busy-flip) [65.939823] Starting subtest: 2x-busy-flip [65.948886] Subtest 2x-busy-flip: SKIP (0.011s) [66.026364] [006/133] (955s left) kms_plane_lowres (tiling-x) [66.111391] Starting subtest: tiling-x [66.113754] Starting dynamic subtest: pipe-A-eDP-1 [66.118423] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [66.401711] Starting dynamic subtest: pipe-B-eDP-1 [66.406342] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [66.413538] Starting dynamic subtest: pipe-C-eDP-1 [66.418229] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [66.426123] Starting dynamic subtest: pipe-D-eDP-1 [66.430651] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [66.435050] Subtest tiling-x: SKIP (0.290s) [67.192738] [007/133] (953s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [67.570084] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [67.575101] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [67.900063] [008/133] (953s left) i915_suspend (fence-restore-untiled) [68.129084] Starting subtest: fence-restore-untiled [68.133857] Subtest fence-restore-untiled: SKIP (0.000s) [68.228186] [009/133] (953s left) gem_userptr_blits (nohangcheck) [68.304462] Starting subtest: nohangcheck [68.549569] Subtest nohangcheck: SUCCESS (0.242s) [68.663278] [010/133] (952s left) api_intel_allocator (reloc-allocator) [68.729878] Starting subtest: reloc-allocator [68.731925] Starting dynamic subtest: basic [68.734348] Dynamic subtest basic: SUCCESS (0.003s) [68.743024] Starting dynamic subtest: parallel-one [68.745260] Dynamic subtest parallel-one: SUCCESS (0.008s) [68.752580] Starting dynamic subtest: print [68.754459] Dynamic subtest print: SUCCESS (0.000s) [68.762300] Starting dynamic subtest: reuse [68.764401] Dynamic subtest reuse: SUCCESS (0.000s) [68.771515] Starting dynamic subtest: fork-reopen-allocator [68.773630] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s) [68.775706] Subtest reloc-allocator: SUCCESS (0.027s) [68.873597] [011/133] (952s left) i915_pm_rpm (gem-execbuf) [71.102486] Starting subtest: gem-execbuf [71.105055] Starting dynamic subtest: smem0 [72.817042] Dynamic subtest smem0: SUCCESS (1.719s) [72.819462] Subtest gem-execbuf: SUCCESS (1.720s) [72.901396] [012/133] (948s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [72.998795] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [76.689879] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.697s) [77.900028] [013/133] (943s left) vgem_basic (sysfs) [77.982791] Starting subtest: sysfs [77.984648] Subtest sysfs: SUCCESS (0.000s) [78.055165] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true [78.058189] [014/133] (943s left) perf (sysctl-defaults) [78.133353] Starting subtest: sysctl-defaults [78.135795] Subtest sysctl-defaults: SUCCESS (0.000s) [78.228200] [015/133] (943s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [78.299648] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [78.304315] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [78.482483] [016/133] (943s left) kms_hdr (bpc-switch-dpms) [78.576520] Starting subtest: bpc-switch-dpms [79.639925] Starting dynamic subtest: pipe-A-eDP-1 [84.064912] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.425s) [84.067313] Subtest bpc-switch-dpms: SUCCESS (5.489s) [84.168894] [017/133] (937s left) i915_query (query-topology-matches-eu-total) [84.224918] Starting subtest: query-topology-matches-eu-total [84.226893] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [84.317249] [018/133] (937s left) perf (blocking-parameterized) [84.420583] Starting subtest: blocking-parameterized [104.438128] Subtest blocking-parameterized: SUCCESS (20.018s) [104.486959] [019/133] (917s left) kms_prop_blob (blob-prop-lifetime) [104.547659] Starting subtest: blob-prop-lifetime [104.549937] Subtest blob-prop-lifetime: SUCCESS (0.001s) [104.661082] [020/133] (917s left) perf_pmu (rc6) [104.701387] Starting subtest: rc6 [104.703237] Starting dynamic subtest: gt0 [111.078335] Dynamic subtest gt0: SUCCESS (6.376s) [111.087671] Starting dynamic subtest: runtime-pm-gt0 [118.799900] Dynamic subtest runtime-pm-gt0: SUCCESS (7.721s) [118.810718] Starting dynamic subtest: runtime-pm-long-gt0 [131.299820] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.499s) [131.310751] Starting dynamic subtest: other-idle-gt0 [137.641437] Dynamic subtest other-idle-gt0: SUCCESS (6.340s) [137.651923] Starting dynamic subtest: gt1 [143.981339] Dynamic subtest gt1: SUCCESS (6.339s) [143.992558] Starting dynamic subtest: runtime-pm-gt1 [151.474946] Dynamic subtest runtime-pm-gt1: SUCCESS (7.492s) [151.486235] Starting dynamic subtest: runtime-pm-long-gt1 [163.955970] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.478s) [163.966779] Starting dynamic subtest: other-idle-gt1 [170.302615] Dynamic subtest other-idle-gt1: SUCCESS (6.342s) [170.305783] Subtest rc6: SUCCESS (65.597s) [171.439601] [021/133] (850s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [171.542430] Starting subtest: psr2-cursor-plane-move-continuous-sf [171.544626] Starting dynamic subtest: pipe-A-eDP-1 [181.891490] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.351s) [181.900752] Starting dynamic subtest: pipe-B-eDP-1 [192.940535] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.046s) [192.942826] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.399s) [193.720377] [022/133] (828s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [193.819172] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [193.823214] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [193.888423] [023/133] (827s left) fbdev (unaligned-read) [193.927605] Starting subtest: unaligned-read [193.942425] Subtest unaligned-read: SUCCESS (0.015s) [193.981493] [024/133] (827s left) gem_ctx_isolation (nonpriv) [194.042856] Starting subtest: nonpriv [194.045203] Starting dynamic subtest: rcs0 [194.283364] Dynamic subtest rcs0: SUCCESS (0.240s) [194.294150] Starting dynamic subtest: bcs0 [194.546802] Dynamic subtest bcs0: SUCCESS (0.263s) [194.556682] Starting dynamic subtest: vcs0 [194.822049] Dynamic subtest vcs0: SUCCESS (0.275s) [194.832257] Starting dynamic subtest: vcs1 [196.124992] Dynamic subtest vcs1: SUCCESS (1.302s) [196.133771] Starting dynamic subtest: vecs0 [198.159928] Dynamic subtest vecs0: SUCCESS (2.034s) [198.168181] Starting dynamic subtest: ccs0 [200.154388] Dynamic subtest ccs0: SUCCESS (1.994s) [200.156777] Subtest nonpriv: SUCCESS (6.111s) [200.350384] [025/133] (821s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [200.452232] Starting subtest: yf-tiled-32bpp-rotate-180 [200.456558] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [200.526051] [026/133] (821s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [200.577248] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [200.651728] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.013s) [200.692012] [027/133] (821s left) kms_psr (fbc-psr-suspend) [200.794211] Starting subtest: fbc-psr-suspend [200.796453] Starting dynamic subtest: eDP-1 [200.800745] Dynamic subtest eDP-1: SKIP (0.000s) [200.805185] Subtest fbc-psr-suspend: SKIP (0.000s) [200.846590] [028/133] (821s left) prime_self_import (basic-with_one_bo_two_files) [200.886967] Starting subtest: basic-with_one_bo_two_files [200.904763] Subtest basic-with_one_bo_two_files: SUCCESS (0.020s) [200.985075] [029/133] (821s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [201.092566] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [201.097044] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [201.178841] [030/133] (820s left) gem_exec_params (invalid-flag) [201.226644] Starting subtest: invalid-flag [201.229075] Subtest invalid-flag: SUCCESS (0.000s) [201.304788] [031/133] (820s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [201.395656] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [201.399077] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [201.464536] [032/133] (820s left) sw_sync (sync_merge) [201.500848] Starting subtest: sync_merge [201.502767] Subtest sync_merge: SUCCESS (0.000s) [201.537196] [033/133] (820s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [201.596063] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [201.597963] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [201.669232] [034/133] (820s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [201.789086] Starting subtest: nonblocking-modeset-vs-cursor-atomic [203.217056] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.426s) [203.997331] [035/133] (818s left) drm_mm (drm_mm) [204.034784] Starting subtest: drm_mm [204.053437] Starting dynamic subtest: drm_test_mm_init [204.139444] Dynamic subtest drm_test_mm_init: SUCCESS (0.087s) [204.147201] Starting dynamic subtest: drm_test_mm_debug [204.240038] Dynamic subtest drm_test_mm_debug: SUCCESS (0.097s) [204.248788] Starting dynamic subtest: drm_test_mm_align32 [204.341278] Dynamic subtest drm_test_mm_align32: SUCCESS (0.105s) [204.350293] Starting dynamic subtest: drm_test_mm_align64 [204.422979] Dynamic subtest drm_test_mm_align64: SUCCESS (0.080s) [204.431409] Starting dynamic subtest: drm_test_mm_lowest [204.533808] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.108s) [204.546831] Starting dynamic subtest: drm_test_mm_highest [204.618446] Dynamic subtest drm_test_mm_highest: SUCCESS (0.085s) [204.620842] Subtest drm_mm: SUCCESS (0.584s) [204.730191] [036/133] (817s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [204.827396] Starting subtest: 2x-flip-vs-absolute-wf_vblank [204.841602] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.013s) [204.901228] [037/133] (817s left) gem_lmem_swapping (random-engines) [204.947863] Subtest random-engines: SKIP (0.000s) [204.984539] [038/133] (817s left) kms_content_protection (srm) [205.110783] Starting subtest: srm [205.116889] Subtest srm: SKIP (0.002s) [205.208817] [039/133] (817s left) kms_psr (fbc-psr2-no-drrs) [205.293485] Starting subtest: fbc-psr2-no-drrs [205.295464] Starting dynamic subtest: eDP-1 [205.298948] Dynamic subtest eDP-1: SKIP (0.000s) [205.302520] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [205.342828] [040/133] (817s left) syncobj_wait (multi-wait-for-submit-signaled) [205.402819] Starting subtest: multi-wait-for-submit-signaled [205.404886] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [205.480616] [041/133] (817s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier) [205.564329] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier [205.591383] Starting dynamic subtest: pipe-A-plane-0 [206.058016] Dynamic subtest pipe-A-plane-0: SUCCESS (0.467s) [206.065791] Starting dynamic subtest: pipe-A-plane-3 [206.313948] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s) [206.323136] Starting dynamic subtest: pipe-A-plane-5 [206.326861] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [207.412544] Starting dynamic subtest: pipe-B-plane-0 [207.849346] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s) [207.860193] Starting dynamic subtest: pipe-B-plane-3 [208.105050] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s) [208.113610] Starting dynamic subtest: pipe-B-plane-5 [208.117701] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [208.415489] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.850s) [209.267805] [042/133] (813s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [209.367383] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [213.645933] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.283s) [214.769954] [043/133] (807s left) kms_addfb_basic (legacy-format) [214.819691] Starting subtest: legacy-format [214.844877] Subtest legacy-format: SUCCESS (0.024s) [214.947907] [044/133] (807s left) gem_mmap_wc (read) [215.002449] Subtest read: SKIP (0.000s) [215.084010] [045/133] (807s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [215.179315] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [215.183699] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s) [215.238728] [046/133] (807s left) kms_big_fb (4-tiled-16bpp-rotate-90) [215.341740] Starting subtest: 4-tiled-16bpp-rotate-90 [215.361439] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [215.460314] [047/133] (807s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [215.557465] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [215.561801] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [216.691364] [048/133] (806s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs) [216.781745] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs [216.784035] Starting dynamic subtest: pipe-A-eDP-1 [216.792669] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [216.801855] Starting dynamic subtest: pipe-B-eDP-1 [216.810421] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [216.818803] Starting dynamic subtest: pipe-C-eDP-1 [216.827288] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [216.835058] Starting dynamic subtest: pipe-D-eDP-1 [216.843245] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [216.847472] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s) [219.043882] [049/133] (803s left) gem_ctx_persistence (hang) [219.097543] Starting subtest: hang [219.102198] Subtest hang: SKIP (0.000s) [219.178248] [050/133] (803s left) kms_cursor_crc (cursor-random-128x42) [219.433689] Starting subtest: cursor-random-128x42 [219.480894] Subtest cursor-random-128x42: SKIP (0.044s) [219.646546] [051/133] (803s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [219.698024] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [219.700318] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [219.778795] [052/133] (803s left) kms_psr (psr-suspend) [219.880987] Starting subtest: psr-suspend [219.883232] Starting dynamic subtest: eDP-1 [238.311330] Dynamic subtest eDP-1: SUCCESS (3.414s) [238.313837] Subtest psr-suspend: SUCCESS (3.414s) [247.188461] [053/133] (783s left) kms_selftest (drm_damage_helper) [247.244445] Starting subtest: drm_damage_helper [247.258975] Starting dynamic subtest: drm_test_damage_iter_no_damage [247.343335] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.084s) [247.352485] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [247.431030] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.087s) [247.440044] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [247.520436] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.090s) [247.530356] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [247.609869] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.087s) [247.619142] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [247.692475] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.083s) [247.702699] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [247.806859] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.107s) [247.817553] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [247.891099] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.089s) [247.901546] Starting dynamic subtest: drm_test_damage_iter_simple_damage [247.974061] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.083s) [247.983589] Starting dynamic subtest: drm_test_damage_iter_single_damage [248.072073] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.097s) [248.081293] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [248.165341] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.094s) [248.175879] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [248.253194] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.089s) [248.261813] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [248.343569] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.090s) [248.352343] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [248.428554] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.088s) [248.436770] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [248.516721] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.087s) [248.526307] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [248.604748] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.091s) [248.614103] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [248.694400] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.089s) [248.704264] Starting dynamic subtest: drm_test_damage_iter_damage [248.779685] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.086s) [248.789616] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [248.864951] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.086s) [248.873311] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [248.950653] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.086s) [248.959981] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [249.037525] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.088s) [249.046911] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [249.129519] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.094s) [249.131389] Subtest drm_damage_helper: SUCCESS (1.911s) [249.260822] [054/133] (781s left) gem_exec_balancer (parallel-ordering) [249.516514] Starting subtest: parallel-ordering [250.485321] Subtest parallel-ordering: SUCCESS (0.988s) [250.614170] [055/133] (780s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite) [250.725801] Starting subtest: fbcpsr-rgb565-draw-pwrite [257.684840] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.035s) [257.775862] [056/133] (773s left) gem_mmap_offset (oob-read) [257.838729] Starting subtest: oob-read [257.840573] Subtest oob-read: SUCCESS (0.000s) [257.905949] [057/133] (773s left) perf_pmu (busy-idle) [257.946617] Starting subtest: busy-idle [257.948793] Starting dynamic subtest: rcs0 [258.627785] Dynamic subtest rcs0: SUCCESS (0.687s) [258.639464] Starting dynamic subtest: bcs0 [259.324649] Dynamic subtest bcs0: FAIL (0.635s) [259.335172] Starting dynamic subtest: vcs0 [260.928091] Dynamic subtest vcs0: SUCCESS (1.672s) [260.940125] Starting dynamic subtest: vcs1 [262.911988] Dynamic subtest vcs1: SUCCESS (1.989s) [262.922358] Starting dynamic subtest: vecs0 [263.613801] Dynamic subtest vecs0: FAIL (0.636s) [263.624208] Starting dynamic subtest: ccs0 [265.648872] Dynamic subtest ccs0: FAIL (2.041s) [265.651070] Subtest busy-idle: FAIL (7.670s) [265.692091] [058/133] (765s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [265.789827] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [265.794058] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [265.868541] [059/133] (765s left) kms_pipe_crc_basic (read-crc-frame-sequence) [265.965300] Starting subtest: read-crc-frame-sequence [265.967532] Starting dynamic subtest: pipe-A-eDP-1 [266.677038] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s) [266.686062] Starting dynamic subtest: pipe-B-eDP-1 [268.078298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s) [268.088246] Starting dynamic subtest: pipe-C-eDP-1 [269.436118] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.359s) [269.445770] Starting dynamic subtest: pipe-D-eDP-1 [270.767804] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s) [270.770185] Subtest read-crc-frame-sequence: SUCCESS (4.811s) [271.577458] [060/133] (759s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [271.691675] Starting subtest: cursorA-vs-flipA-atomic [282.822853] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.135s) [283.607939] [061/133] (747s left) kms_chamelium_color (ctm-limited-range) [283.708819] Subtest ctm-limited-range: SKIP (0.000s) [283.757986] [062/133] (747s left) kms_flip (2x-modeset-vs-vblank-race) [283.856942] Starting subtest: 2x-modeset-vs-vblank-race [283.865636] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s) [283.924335] [063/133] (747s left) kms_ccs (bad-aux-stride-y-tiled-ccs) [284.012470] Starting subtest: bad-aux-stride-y-tiled-ccs [284.014747] Starting dynamic subtest: pipe-A-eDP-1 [284.037624] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [284.049496] Starting dynamic subtest: pipe-B-eDP-1 [284.069642] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [284.077663] Starting dynamic subtest: pipe-C-eDP-1 [284.098164] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [284.106599] Starting dynamic subtest: pipe-D-eDP-1 [284.127239] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [284.131552] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s) [286.186209] [064/133] (745s left) gem_eio (in-flight-external) [286.392190] Starting subtest: in-flight-external [287.997735] Subtest in-flight-external: SUCCESS (1.607s) [288.106355] [065/133] (743s left) kms_rotation_crc (sprite-rotation-180) [288.192122] Starting subtest: sprite-rotation-180 [295.091161] Subtest sprite-rotation-180: SUCCESS (6.902s) [296.255656] [066/133] (735s left) syncobj_timeline (wait-delayed-signal) [296.311232] Starting subtest: wait-delayed-signal [296.412848] Subtest wait-delayed-signal: SUCCESS (0.102s) [296.470007] [067/133] (735s left) kms_flip (2x-flip-vs-dpms-on-nop) [296.563799] Starting subtest: 2x-flip-vs-dpms-on-nop [296.573102] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s) [296.633131] [068/133] (735s left) kms_vrr (flip-dpms) [296.727717] Starting subtest: flip-dpms [296.734467] Subtest flip-dpms: SKIP (0.000s) [296.778058] [069/133] (734s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [296.874451] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [303.438768] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.569s) [303.516208] [070/133] (728s left) gem_exec_schedule (preempt-self) [303.595619] Starting subtest: preempt-self [303.597554] Starting dynamic subtest: rcs0 [303.608515] Dynamic subtest rcs0: SUCCESS (0.021s) [303.619252] Starting dynamic subtest: bcs0 [303.633629] Dynamic subtest bcs0: SUCCESS (0.024s) [303.643320] Starting dynamic subtest: vcs0 [303.655099] Dynamic subtest vcs0: SUCCESS (0.021s) [303.664611] Starting dynamic subtest: vcs1 [303.675511] Dynamic subtest vcs1: SUCCESS (0.020s) [303.684793] Starting dynamic subtest: vecs0 [303.696027] Dynamic subtest vecs0: SUCCESS (0.020s) [303.705594] Starting dynamic subtest: ccs0 [303.716388] Dynamic subtest ccs0: SUCCESS (0.019s) [303.718661] Subtest preempt-self: SUCCESS (0.130s) [305.034617] [071/133] (726s left) kms_cursor_legacy (forked-move) [305.163716] Starting subtest: forked-move [305.165970] Starting dynamic subtest: pipe-A [310.663432] Dynamic subtest pipe-A: SUCCESS (5.497s) [310.675360] Starting dynamic subtest: pipe-B [316.133544] Dynamic subtest pipe-B: SUCCESS (5.470s) [316.145514] Starting dynamic subtest: pipe-C [321.605177] Dynamic subtest pipe-C: SUCCESS (5.472s) [321.617470] Starting dynamic subtest: pipe-D [327.075394] Dynamic subtest pipe-D: SUCCESS (5.469s) [327.086304] Starting dynamic subtest: all-pipes [332.576994] Dynamic subtest all-pipes: SUCCESS (5.501s) [332.579453] Subtest forked-move: SUCCESS (27.421s) [332.707193] [072/133] (699s left) prime_vgem (basic-fence-mmap) [332.784577] Starting subtest: basic-fence-mmap [332.789528] Subtest basic-fence-mmap: SKIP (0.000s) [332.864256] [073/133] (699s left) gem_ctx_shared (detached-shared-gtt) [332.937352] Starting subtest: detached-shared-gtt [335.088377] Subtest detached-shared-gtt: SUCCESS (2.152s) [335.375434] [074/133] (696s left) gem_create (create-ext-placement-each) [335.542587] Starting subtest: create-ext-placement-each [335.545023] Subtest create-ext-placement-each: SUCCESS (0.000s) [335.618865] [075/133] (696s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [335.720114] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [335.724647] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [335.793908] [076/133] (696s left) kms_draw_crc (draw-method-mmap-gtt) [335.881757] Starting subtest: draw-method-mmap-gtt [335.886121] Subtest draw-method-mmap-gtt: SKIP (0.000s) [335.961969] [077/133] (696s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [336.058389] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [336.060731] Starting dynamic subtest: pipe-A [336.121580] Dynamic subtest pipe-A: SUCCESS (0.065s) [336.132420] Starting dynamic subtest: pipe-B [337.222229] Dynamic subtest pipe-B: SUCCESS (1.100s) [337.234232] Starting dynamic subtest: pipe-C [338.331897] Dynamic subtest pipe-C: SUCCESS (1.108s) [338.343548] Starting dynamic subtest: pipe-D [339.470244] Dynamic subtest pipe-D: SUCCESS (1.138s) [339.472550] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.416s) [340.620456] [078/133] (691s left) kms_big_fb (y-tiled-16bpp-rotate-270) [340.724029] Starting subtest: y-tiled-16bpp-rotate-270 [340.728090] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [340.801627] [079/133] (691s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [340.861949] Starting subtest: x-tiled-to-vebox-y-tiled [340.866447] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [341.020575] [080/133] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [341.113844] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [341.118152] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [341.199192] [081/133] (691s left) kms_plane (plane-position-hole) [341.296590] Starting subtest: plane-position-hole [341.820724] Starting dynamic subtest: pipe-A-plane-1 [343.126711] Dynamic subtest pipe-A-plane-1: SUCCESS (1.304s) [343.137007] Starting dynamic subtest: pipe-A-plane-2 [344.461974] Dynamic subtest pipe-A-plane-2: SUCCESS (1.331s) [344.473049] Starting dynamic subtest: pipe-A-plane-3 [345.774187] Dynamic subtest pipe-A-plane-3: SUCCESS (1.312s) [345.793486] Starting dynamic subtest: pipe-A-plane-4 [347.090539] Dynamic subtest pipe-A-plane-4: SUCCESS (1.316s) [347.101231] Starting dynamic subtest: pipe-A-plane-5 [347.121931] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s) [348.271700] Starting dynamic subtest: pipe-B-plane-1 [349.586438] Dynamic subtest pipe-B-plane-1: SUCCESS (1.321s) [349.597173] Starting dynamic subtest: pipe-B-plane-2 [350.928022] Dynamic subtest pipe-B-plane-2: SUCCESS (1.341s) [350.946880] Starting dynamic subtest: pipe-B-plane-3 [352.239879] Dynamic subtest pipe-B-plane-3: SUCCESS (1.309s) [352.251089] Starting dynamic subtest: pipe-B-plane-4 [353.583910] Dynamic subtest pipe-B-plane-4: SUCCESS (1.343s) [353.594127] Starting dynamic subtest: pipe-B-plane-5 [353.609038] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [353.610911] Subtest plane-position-hole: SUCCESS (12.306s) [354.428304] [082/133] (677s left) gem_exec_flush (basic-uc-ro-default) [354.496010] Starting subtest: basic-uc-ro-default [359.957324] Subtest basic-uc-ro-default: SUCCESS (5.459s) [360.128731] [083/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [360.249062] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [367.104638] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.856s) [367.194014] [084/133] (665s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [367.249390] Starting subtest: single-wait-all-for-submit-available-signaled [367.251680] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [367.319928] [085/133] (665s left) gem_exec_fence (submit3) [367.499383] Starting subtest: submit3 [367.503737] Subtest submit3: SKIP (0.000s) [369.020101] [086/133] (663s left) kms_busy (basic) [369.116666] Starting subtest: basic [369.119173] Starting dynamic subtest: flip [369.714618] Dynamic subtest flip: SUCCESS (0.599s) [369.725568] Starting dynamic subtest: modeset [373.119093] Dynamic subtest modeset: SUCCESS (3.403s) [373.121541] Subtest basic: SUCCESS (4.004s) [373.894761] [087/133] (658s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [373.998820] Starting subtest: crc-primary-basic-y-tiled-ccs [374.001110] Starting dynamic subtest: pipe-A-eDP-1 [374.024621] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [374.037135] Starting dynamic subtest: pipe-B-eDP-1 [374.059285] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [374.068640] Starting dynamic subtest: pipe-C-eDP-1 [374.090170] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [374.099579] Starting dynamic subtest: pipe-D-eDP-1 [374.121158] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [374.125269] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [376.167897] [088/133] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [376.266912] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [376.270768] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [376.344990] [089/133] (656s left) gem_softpin (evict-single-offset) [376.398823] Starting subtest: evict-single-offset [401.921020] Subtest evict-single-offset: SUCCESS (25.521s) [401.985186] [090/133] (630s left) gem_sync (basic-each) [402.095553] Starting subtest: basic-each [404.496736] Subtest basic-each: SUCCESS (2.411s) [404.663422] [091/133] (628s left) gem_ctx_param (invalid-param-set) [404.712287] Starting subtest: invalid-param-set [404.714645] Subtest invalid-param-set: SUCCESS (0.000s) [404.766181] [092/133] (627s left) kms_color (ctm-0-25) [404.870625] Starting subtest: ctm-0-25 [404.872801] Starting dynamic subtest: pipe-A-eDP-1 [408.421899] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.552s) [408.432203] Starting dynamic subtest: pipe-B-eDP-1 [412.683874] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.263s) [412.695268] Starting dynamic subtest: pipe-C-eDP-1 [416.730126] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.044s) [416.740318] Starting dynamic subtest: pipe-D-eDP-1 [420.835845] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.107s) [420.838234] Subtest ctm-0-25: SUCCESS (15.969s) [421.647160] [093/133] (611s left) kms_psr (fbc-psr-cursor-mmap-gtt) [421.745453] Starting subtest: fbc-psr-cursor-mmap-gtt [421.747616] Starting dynamic subtest: eDP-1 [421.751631] Dynamic subtest eDP-1: SKIP (0.000s) [421.755656] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s) [421.796336] [094/133] (611s left) syncobj_timeline (invalid-transfer-illegal-handle) [421.853962] Starting subtest: invalid-transfer-illegal-handle [421.856169] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [421.904798] [095/133] (610s left) gem_exec_params (invalid-bsd1-flag-on-blt) [421.952636] Starting subtest: invalid-bsd1-flag-on-blt [421.954959] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [422.036000] [096/133] (610s left) kms_async_flips (test-cursor-atomic) [422.134537] Starting subtest: test-cursor-atomic [422.509013] Starting dynamic subtest: pipe-A-eDP-1 [423.252049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s) [423.647662] Starting dynamic subtest: pipe-B-eDP-1 [424.385695] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.749s) [424.763422] Starting dynamic subtest: pipe-C-eDP-1 [425.526625] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s) [425.900634] Starting dynamic subtest: pipe-D-eDP-1 [426.658793] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s) [426.661130] Subtest test-cursor-atomic: SUCCESS (4.529s) [427.803401] [097/133] (605s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [427.905704] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [427.909950] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [427.976632] [098/133] (605s left) gem_eio (in-flight-internal-1us) [428.212690] Starting subtest: in-flight-internal-1us [430.034927] Subtest in-flight-internal-1us: SUCCESS (1.823s) [430.157084] [099/133] (602s left) gem_lmem_swapping (heavy-multi) [430.204968] Subtest heavy-multi: SKIP (0.000s) [430.258203] [100/133] (602s left) kms_psr (psr2-cursor-plane-onoff) [430.343570] Starting subtest: psr2-cursor-plane-onoff [430.345967] Starting dynamic subtest: eDP-1 [432.112785] Dynamic subtest eDP-1: SUCCESS (1.769s) [432.114953] Subtest psr2-cursor-plane-onoff: SUCCESS (1.770s) [432.899077] [101/133] (600s left) kms_frontbuffer_tracking (fbc-stridechange) [432.990752] Starting subtest: fbc-stridechange [436.280427] Subtest fbc-stridechange: SUCCESS (3.293s) [437.395224] [102/133] (595s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [437.491067] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf [437.493204] Starting dynamic subtest: pipe-A-eDP-1 [448.788022] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.304s) [448.799812] Starting dynamic subtest: pipe-B-eDP-1 [460.811308] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.025s) [460.814021] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.331s) [461.644139] [103/133] (571s left) i915_fb_tiling (basic-x-tiling) [461.716549] Subtest basic-x-tiling: SKIP (0.000s) [461.797372] [104/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [461.893111] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [469.221879] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.334s) [469.328890] [105/133] (563s left) gem_exec_schedule (preemptive-hang) [469.511215] Starting subtest: preemptive-hang [469.513732] Starting dynamic subtest: rcs0 [479.022736] Dynamic subtest rcs0: SUCCESS (9.506s) [479.035190] Starting dynamic subtest: bcs0 [488.040511] Dynamic subtest bcs0: SUCCESS (9.012s) [488.051270] Starting dynamic subtest: vcs0 [497.065958] Dynamic subtest vcs0: SUCCESS (9.025s) [497.077402] Starting dynamic subtest: vcs1 [506.088020] Dynamic subtest vcs1: SUCCESS (9.017s) [506.100123] Starting dynamic subtest: vecs0 [515.047028] Dynamic subtest vecs0: SUCCESS (8.956s) [515.059155] Starting dynamic subtest: ccs0 [524.071186] Dynamic subtest ccs0: SUCCESS (9.021s) [524.073622] Subtest preemptive-hang: SUCCESS (54.548s) [524.278823] [106/133] (509s left) kms_prime (basic-modeset-hybrid) [524.379157] Subtest basic-modeset-hybrid: SKIP (0.000s) [524.429672] [107/133] (508s left) gem_exec_whisper (basic-forked-all) [524.485109] Starting subtest: basic-forked-all [538.313235] Subtest basic-forked-all: SUCCESS (13.824s) [538.478758] [108/133] (494s left) gem_basic (create-close) [538.527617] Starting subtest: create-close [538.531816] Subtest create-close: SUCCESS (0.000s) [538.613419] [109/133] (494s left) api_intel_bb (misplaced-blitter) [538.670028] Starting subtest: misplaced-blitter [538.681125] Subtest misplaced-blitter: SUCCESS (0.013s) [538.782338] [110/133] (494s left) gen9_exec_parse (bb-start-cmd) [538.849932] Subtest bb-start-cmd: SKIP (0.000s) [538.930811] [111/133] (494s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [539.038701] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [542.591244] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.556s) [543.782897] [112/133] (489s left) gem_eio (in-flight-contexts-10ms) [544.010040] Starting subtest: in-flight-contexts-10ms [555.929123] Subtest in-flight-contexts-10ms: SUCCESS (11.918s) [556.067179] [113/133] (477s left) i915_drm_fdinfo (isolation) [556.112038] Starting subtest: isolation [556.114234] Starting dynamic subtest: rcs0 [556.139520] Dynamic subtest rcs0: SKIP (0.028s) [556.152220] Starting dynamic subtest: bcs0 [556.156557] Dynamic subtest bcs0: SKIP (0.001s) [556.166837] Starting dynamic subtest: vcs0 [556.170797] Dynamic subtest vcs0: SKIP (0.001s) [556.180526] Starting dynamic subtest: vcs1 [556.184615] Dynamic subtest vcs1: SKIP (0.000s) [556.194296] Starting dynamic subtest: vecs0 [556.199045] Dynamic subtest vecs0: SKIP (0.000s) [556.211965] Starting dynamic subtest: ccs0 [556.216240] Dynamic subtest ccs0: SKIP (0.000s) [556.220817] Subtest isolation: SKIP (0.039s) [556.261774] [114/133] (477s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [556.306359] Starting subtest: multi-wait-for-submit-available-submitted-signaled [556.308483] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [556.391934] [115/133] (477s left) kms_legacy_colorkey (invalid-plane) [556.484873] Starting subtest: invalid-plane [556.487031] Starting dynamic subtest: zero-id [556.488944] Dynamic subtest zero-id: SUCCESS (0.000s) [556.502219] Starting dynamic subtest: outrange-id [556.504296] Dynamic subtest outrange-id: SUCCESS (0.000s) [556.506544] Subtest invalid-plane: SUCCESS (0.001s) [556.551700] [116/133] (477s left) kms_invalid_mode (clock-too-high) [556.641830] Starting subtest: clock-too-high [556.644071] Starting dynamic subtest: pipe-A-eDP-1 [556.648556] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [556.662792] Starting dynamic subtest: pipe-B-eDP-1 [556.667595] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [556.688943] Starting dynamic subtest: pipe-C-eDP-1 [556.693879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [556.716645] Starting dynamic subtest: pipe-D-eDP-1 [556.721698] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [556.726193] Subtest clock-too-high: SKIP (0.005s) [556.780229] [117/133] (477s left) kms_big_fb (x-tiled-8bpp-rotate-0) [556.881728] Starting subtest: x-tiled-8bpp-rotate-0 [558.151154] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.270s) [558.253659] [118/133] (475s left) kms_frontbuffer_tracking (psr-slowdraw) [558.342397] Starting subtest: psr-slowdraw [583.565414] Subtest psr-slowdraw: SUCCESS (25.227s) [583.670637] [119/133] (450s left) gem_exec_balancer (hang) [583.944239] Starting subtest: hang [585.929426] Subtest hang: SUCCESS (1.989s) [586.016874] [120/133] (447s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [586.116027] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [586.119963] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [586.188446] [121/133] (447s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [586.277710] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [586.281570] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [586.349924] [122/133] (447s left) gem_mmap_wc (bad-object) [586.404925] Subtest bad-object: SKIP (0.000s) [586.468230] [123/133] (447s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [586.562172] Starting subtest: yf-tiled-64bpp-rotate-180 [586.566545] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [586.637876] [124/133] (447s left) gem_busy (close-race) [586.692480] Starting subtest: close-race [609.920055] Subtest close-race: SUCCESS (23.228s) [610.232635] [125/133] (423s left) drm_read (empty-nonblock) [610.445444] Starting subtest: empty-nonblock [610.447565] Subtest empty-nonblock: SUCCESS (0.000s) [610.574018] [126/133] (423s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [610.666812] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [610.670800] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [610.740847] [127/133] (423s left) kms_cursor_edge_walk (256x256-left-edge) [610.833517] Starting subtest: 256x256-left-edge [610.835659] Starting dynamic subtest: pipe-A-eDP-1 [614.287556] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s) [614.298534] Starting dynamic subtest: pipe-D-eDP-1 [617.408982] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s) [617.411266] Subtest 256x256-left-edge: SUCCESS (6.577s) [618.201945] [128/133] (416s left) gem_exec_schedule (fifo) [618.284928] Starting subtest: fifo [618.287211] Starting dynamic subtest: rcs0 [618.379560] Dynamic subtest rcs0: SUCCESS (0.101s) [618.392540] Starting dynamic subtest: vcs0 [618.460802] Dynamic subtest vcs0: SUCCESS (0.080s) [618.471034] Starting dynamic subtest: vcs1 [618.541435] Dynamic subtest vcs1: SUCCESS (0.078s) [618.554204] Starting dynamic subtest: vecs0 [618.619308] Dynamic subtest vecs0: SUCCESS (0.077s) [618.633296] Starting dynamic subtest: ccs0 [618.719976] Dynamic subtest ccs0: SUCCESS (0.100s) [618.722761] Subtest fifo: SUCCESS (0.442s) [619.971103] [129/133] (414s left) kms_fbcon_fbt (psr) [620.021443] Starting subtest: psr [627.360972] Subtest psr: SUCCESS (7.337s) [627.438267] [130/133] (406s left) kms_chamelium_frames (hdmi-aspect-ratio) [627.820674] Subtest hdmi-aspect-ratio: SKIP (0.000s) [628.602700] [131/133] (405s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [628.717373] Starting subtest: 2x-long-cursor-vs-flip-legacy [628.722015] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [628.841449] [132/133] (405s left) kms_big_fb (linear-64bpp-rotate-270) [628.955711] Starting subtest: linear-64bpp-rotate-270 [628.975369] Subtest linear-64bpp-rotate-270: SKIP (0.019s) [629.071086] [133/133] (405s left) testdisplay [629.368185] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: syncobj_timeline results: parsing output: 2/ for test: kms_pm_rpm results: parsing output: 3/ for test: kms_chamelium_hpd results: parsing output: 4/ for test: kms_flip results: parsing output: 5/ for test: kms_plane_lowres results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: i915_suspend results: parsing output: 8/ for test: gem_userptr_blits results: parsing output: 9/ for test: api_intel_allocator results: parsing output: 10/ for test: i915_pm_rpm results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: vgem_basic results: parsing output: 13/ for test: perf results: parsing output: 14/ for test: gem_render_copy results: parsing output: 15/ for test: kms_hdr results: parsing output: 16/ for test: i915_query results: parsing output: 17/ for test: perf results: parsing output: 18/ for test: kms_prop_blob results: parsing output: 19/ for test: perf_pmu results: parsing output: 20/ for test: kms_psr2_sf results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: fbdev results: parsing output: 23/ for test: gem_ctx_isolation results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: sriov_basic results: parsing output: 26/ for test: kms_psr results: parsing output: 27/ for test: prime_self_import results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: gem_exec_params results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: sw_sync results: parsing output: 32/ for test: syncobj_wait results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: drm_mm results: parsing output: 35/ for test: kms_flip results: parsing output: 36/ for test: gem_lmem_swapping results: parsing output: 37/ for test: kms_content_protection results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: syncobj_wait results: parsing output: 40/ for test: kms_plane results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_addfb_basic results: parsing output: 43/ for test: gem_mmap_wc results: parsing output: 44/ for test: kms_flip_scaled_crc results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: gem_ctx_persistence results: parsing output: 49/ for test: kms_cursor_crc results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: kms_psr results: parsing output: 52/ for test: kms_selftest results: parsing output: 53/ for test: gem_exec_balancer results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_mmap_offset results: parsing output: 56/ for test: perf_pmu results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_pipe_crc_basic results: parsing output: 59/ for test: kms_cursor_legacy results: parsing output: 60/ for test: kms_chamelium_color results: parsing output: 61/ for test: kms_flip results: parsing output: 62/ for test: kms_ccs results: parsing output: 63/ for test: gem_eio results: parsing output: 64/ for test: kms_rotation_crc results: parsing output: 65/ for test: syncobj_timeline results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: kms_vrr results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: gem_exec_schedule results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: prime_vgem results: parsing output: 72/ for test: gem_ctx_shared results: parsing output: 73/ for test: gem_create results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_draw_crc results: parsing output: 76/ for test: kms_plane_scaling results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: gem_render_copy results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_plane results: parsing output: 81/ for test: gem_exec_flush results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: gem_exec_fence results: parsing output: 85/ for test: kms_busy results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: gem_softpin results: parsing output: 89/ for test: gem_sync results: parsing output: 90/ for test: gem_ctx_param results: parsing output: 91/ for test: kms_color results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: syncobj_timeline results: parsing output: 94/ for test: gem_exec_params results: parsing output: 95/ for test: kms_async_flips results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_eio results: parsing output: 98/ for test: gem_lmem_swapping results: parsing output: 99/ for test: kms_psr results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_psr2_sf results: parsing output: 102/ for test: i915_fb_tiling results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_prime results: parsing output: 106/ for test: gem_exec_whisper results: parsing output: 107/ for test: gem_basic results: parsing output: 108/ for test: api_intel_bb results: parsing output: 109/ for test: gen9_exec_parse results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: gem_eio results: parsing output: 112/ for test: i915_drm_fdinfo results: parsing output: 113/ for test: syncobj_timeline results: parsing output: 114/ for test: kms_legacy_colorkey results: parsing output: 115/ for test: kms_invalid_mode results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_exec_balancer results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_mmap_wc results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: gem_busy results: parsing output: 124/ for test: drm_read results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_cursor_edge_walk results: parsing output: 127/ for test: gem_exec_schedule results: parsing output: 128/ for test: kms_fbcon_fbt results: parsing output: 129/ for test: kms_chamelium_frames results: parsing output: 130/ for test: kms_cursor_legacy results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: testdisplay Done.