[57.395080] Initializing watchdogs [57.395140] /dev/watchdog0 [57.408909] [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] [57.413318] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.416184] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.419244] [001/132] (960s left) gem_exec_suspend (basic-s0) [57.501827] Starting subtest: basic-S0 [57.504153] Starting dynamic subtest: smem [77.948634] Dynamic subtest smem: SUCCESS (7.252s) [77.951706] Subtest basic-S0: SUCCESS (7.253s) [78.133331] [002/132] (939s left) kms_flip (2x-flip-vs-expired-vblank) [78.238695] Starting subtest: 2x-flip-vs-expired-vblank [78.250402] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s) [78.331471] [003/132] (939s left) kms_big_fb (4-tiled-16bpp-rotate-0) [78.421457] Starting subtest: 4-tiled-16bpp-rotate-0 [79.701777] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.245s) [79.829050] [004/132] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu) [79.934317] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu [79.938187] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [80.054185] [005/132] (938s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [80.259820] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [80.264407] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [80.485326] [006/132] (937s left) kms_chamelium_edid (dp-edid-read) [80.928391] Subtest dp-edid-read: SKIP (0.000s) [81.724999] [007/132] (936s left) kms_prop_blob (blob-prop-lifetime) [81.788279] Starting subtest: blob-prop-lifetime [81.790776] Subtest blob-prop-lifetime: SUCCESS (0.003s) [81.927432] [008/132] (936s left) kms_flip (flip-vs-wf_vblank-interruptible) [82.028221] Starting subtest: flip-vs-wf_vblank-interruptible [82.030810] Starting dynamic subtest: A-eDP1 [83.936327] Dynamic subtest A-eDP1: SUCCESS (1.873s) [83.946218] Starting dynamic subtest: B-eDP1 [85.891573] Dynamic subtest B-eDP1: SUCCESS (1.928s) [85.901678] Starting dynamic subtest: C-eDP1 [87.832360] Dynamic subtest C-eDP1: SUCCESS (1.920s) [87.842045] Starting dynamic subtest: D-eDP1 [89.778517] Dynamic subtest D-eDP1: SUCCESS (1.929s) [89.780954] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.660s) [91.004644] [009/132] (927s left) kms_psr (pr-suspend) [91.100084] Starting subtest: pr-suspend [91.104294] Subtest pr-suspend: SKIP (0.000s) [91.176394] [010/132] (927s left) kms_vblank (ts-continuation-modeset) [91.266848] Starting subtest: ts-continuation-modeset [91.269001] Starting dynamic subtest: pipe-A-eDP-1 [92.772875] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.497s) [92.787275] Starting dynamic subtest: pipe-D-eDP-1 [94.967888] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.185s) [94.970332] Subtest ts-continuation-modeset: SUCCESS (3.685s) [95.767289] [011/132] (922s left) syncobj_wait (multi-wait-submitted-signaled) [95.831020] Starting subtest: multi-wait-submitted-signaled [95.833409] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s) [95.982644] [012/132] (922s left) kms_flip (2x-nonexisting-fb) [96.078825] Starting subtest: 2x-nonexisting-fb [96.087362] Subtest 2x-nonexisting-fb: SKIP (0.010s) [96.164384] [013/132] (922s left) kms_chamelium_hpd (common-hpd-after-suspend) [96.539888] Subtest common-hpd-after-suspend: SKIP (0.000s) [97.372002] [014/132] (921s left) kms_plane_alpha_blend (alpha-basic) [97.462019] Starting subtest: alpha-basic [97.752589] Starting dynamic subtest: pipe-A-eDP-1 [99.657544] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.896s) [99.680190] Starting dynamic subtest: pipe-D-eDP-1 [102.387815] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.706s) [102.390272] Subtest alpha-basic: SUCCESS (4.914s) [103.185795] [015/132] (915s left) kms_content_protection (atomic-dpms-hdcp14) [103.345819] Starting subtest: atomic-dpms-hdcp14 [103.350564] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [103.465050] [016/132] (915s left) kms_cursor_crc (cursor-offscreen-256x256) [103.704778] Starting subtest: cursor-offscreen-256x256 [103.709756] Starting dynamic subtest: pipe-A-eDP-1 [105.643682] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s) [105.667692] Starting dynamic subtest: pipe-D-eDP-1 [108.297086] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.631s) [108.299328] Subtest cursor-offscreen-256x256: SUCCESS (4.585s) [109.142292] [017/132] (909s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [109.246375] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [109.250362] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [109.348274] [018/132] (909s left) gem_ctx_isolation (dirty-create) [109.402725] Starting subtest: dirty-create [109.405097] Starting dynamic subtest: rcs0 [109.588199] Dynamic subtest rcs0: SUCCESS (0.184s) [109.599918] Starting dynamic subtest: bcs0 [109.801462] Dynamic subtest bcs0: SUCCESS (0.213s) [109.812347] Starting dynamic subtest: vcs0 [110.000843] Dynamic subtest vcs0: SUCCESS (0.199s) [110.011179] Starting dynamic subtest: vcs1 [111.152965] Dynamic subtest vcs1: SUCCESS (1.152s) [111.163438] Starting dynamic subtest: vecs0 [113.211571] Dynamic subtest vecs0: SUCCESS (2.057s) [113.221758] Starting dynamic subtest: ccs0 [115.207973] Dynamic subtest ccs0: SUCCESS (1.995s) [115.210448] Subtest dirty-create: SUCCESS (5.804s) [115.441060] [019/132] (903s left) syncobj_wait (wait-any-interrupted) [115.488294] Starting subtest: wait-any-interrupted [115.589538] Subtest wait-any-interrupted: SUCCESS (0.102s) [115.680903] [020/132] (903s left) api_intel_allocator (fork-simple-stress-signal) [115.727395] Starting subtest: fork-simple-stress-signal [121.131146] Subtest fork-simple-stress-signal: SUCCESS (5.402s) [121.250424] [021/132] (897s left) kms_psr (fbc-psr-primary-page-flip) [121.351731] Starting subtest: fbc-psr-primary-page-flip [121.353971] Starting dynamic subtest: eDP-1 [121.358290] Dynamic subtest eDP-1: SKIP (0.000s) [121.362447] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [121.422323] [022/132] (897s left) kms_psr (fbc-psr2-primary-render) [121.530050] Starting subtest: fbc-psr2-primary-render [121.532295] Starting dynamic subtest: eDP-1 [121.536385] Dynamic subtest eDP-1: SKIP (0.000s) [121.540305] Subtest fbc-psr2-primary-render: SKIP (0.001s) [121.600397] [023/132] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [121.694515] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [129.176489] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.481s) [129.296840] [024/132] (889s left) kms_plane_multiple (tiling-yf) [129.392234] Starting subtest: tiling-yf [129.396300] Subtest tiling-yf: SKIP (0.000s) [129.473157] [025/132] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy) [129.560398] Starting subtest: addfb25-y-tiled-legacy [129.562345] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [129.657350] [026/132] (889s left) i915_pm_rc6_residency (rc6-accuracy) [129.718299] Starting subtest: rc6-accuracy [129.720482] Starting dynamic subtest: gt0 [132.891184] Dynamic subtest gt0: SUCCESS (3.168s) [132.901830] Starting dynamic subtest: gt1 [136.061422] Dynamic subtest gt1: SUCCESS (3.167s) [136.063963] Subtest rc6-accuracy: SUCCESS (6.339s) [136.132630] [027/132] (882s left) syncobj_eventfd (binary-wait-before-signal) [136.193451] Starting subtest: binary-wait-before-signal [136.222471] Subtest binary-wait-before-signal: SUCCESS (0.031s) [136.311349] [028/132] (882s left) syncobj_basic (bad-handle-to-fd) [136.372811] Starting subtest: bad-handle-to-fd [136.374695] Subtest bad-handle-to-fd: SUCCESS (0.000s) [136.467713] [029/132] (882s left) gem_exec_balancer (invalid-bonds) [136.532068] Starting subtest: invalid-bonds [136.537153] Subtest invalid-bonds: SKIP (0.000s) [136.828156] [030/132] (882s left) gem_userptr_blits (mmap-offset-banned) [136.886561] Starting subtest: mmap-offset-banned [136.888847] Starting dynamic subtest: wb [136.891124] Dynamic subtest wb: SUCCESS (0.000s) [136.899886] Starting dynamic subtest: wc [136.901961] Dynamic subtest wc: SUCCESS (0.000s) [136.909258] Starting dynamic subtest: uc [136.911171] Dynamic subtest uc: SUCCESS (0.000s) [136.913054] Subtest mmap-offset-banned: SUCCESS (0.001s) [137.006126] [031/132] (882s left) gem_exec_reloc (basic-write-cpu) [137.066142] Subtest basic-write-cpu: SKIP (0.000s) [137.135391] [032/132] (882s left) kms_addfb_basic (too-high) [137.234767] Starting subtest: too-high [137.236698] Subtest too-high: SUCCESS (0.000s) [137.346083] [033/132] (881s left) perf (non-system-wide-paranoid) [137.499378] Starting subtest: non-system-wide-paranoid [137.526002] Subtest non-system-wide-paranoid: SUCCESS (0.028s) [137.579464] [034/132] (881s left) kms_chamelium_color (ctm-0-50) [137.689929] Subtest ctm-0-50: SKIP (0.000s) [137.733090] [035/132] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [137.823929] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [137.827555] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [137.929135] [036/132] (881s left) tools_test (tools_test) [137.972107] Starting subtest: tools_test [138.016984] Subtest tools_test: SUCCESS (0.058s) [138.090580] [037/132] (881s left) gem_ctx_exec (basic-close-race) [138.143313] Starting subtest: basic-close-race [143.808822] Subtest basic-close-race: SUCCESS (5.661s) [143.952477] [038/132] (875s left) perf (invalid-oa-format-id) [144.059038] Starting subtest: invalid-oa-format-id [144.065731] Subtest invalid-oa-format-id: SUCCESS (0.009s) [144.104741] [039/132] (875s left) kms_pm_rpm (basic-pci-d3-state) [146.138424] Starting subtest: basic-pci-d3-state [147.596334] Subtest basic-pci-d3-state: SUCCESS (1.459s) [147.697362] [040/132] (871s left) kms_psr (psr-primary-mmap-gtt) [147.797296] Starting subtest: psr-primary-mmap-gtt [147.799639] Starting dynamic subtest: eDP-1 [149.248782] Dynamic subtest eDP-1: SKIP (1.448s) [149.254054] Subtest psr-primary-mmap-gtt: SKIP (1.449s) [149.383196] [041/132] (870s left) gem_mmap_gtt (cpuset-big-copy) [149.438860] Subtest cpuset-big-copy: SKIP (0.000s) [149.501944] [042/132] (870s left) gem_mmap_gtt (zero-extend) [149.564405] Subtest zero-extend: SKIP (0.000s) [149.621444] [043/132] (870s left) kms_frontbuffer_tracking (psr-suspend) [149.718594] Starting subtest: psr-suspend [187.459952] Subtest psr-suspend: SUCCESS (7.859s) [187.594097] [044/132] (832s left) kms_debugfs (display-off-read-all) [187.707409] Starting subtest: display-off-read-all [188.002860] Subtest display-off-read-all: SUCCESS (0.295s) [188.861250] [045/132] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [188.960463] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [188.964679] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [189.058165] [046/132] (830s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [189.163802] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [196.208326] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.043s) [196.339993] [047/132] (823s left) gem_exec_fence (long-history) [196.806689] Starting subtest: long-history [203.635786] Subtest long-history: SUCCESS (6.827s) [204.104535] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true [204.107786] [048/132] (815s left) gem_ringfill (engines-basic) [209.914414] Starting subtest: engines-basic [209.916984] Starting dynamic subtest: rcs0 [209.970130] Dynamic subtest rcs0: SUCCESS (0.056s) [209.981032] Starting dynamic subtest: bcs0 [210.013283] Dynamic subtest bcs0: SUCCESS (0.042s) [210.023099] Starting dynamic subtest: vcs0 [210.055212] Dynamic subtest vcs0: SUCCESS (0.040s) [210.064639] Starting dynamic subtest: vcs1 [210.098347] Dynamic subtest vcs1: SUCCESS (0.041s) [210.109588] Starting dynamic subtest: vecs0 [210.142028] Dynamic subtest vecs0: SUCCESS (0.042s) [210.156458] Starting dynamic subtest: ccs0 [210.187770] Dynamic subtest ccs0: SUCCESS (0.044s) [210.190191] Subtest engines-basic: SUCCESS (0.276s) [210.270112] [049/132] (809s left) gem_exec_schedule (pi-common) [210.454534] Starting subtest: pi-common [210.456990] Starting dynamic subtest: rcs0 [210.482583] Dynamic subtest rcs0: SUCCESS (0.031s) [210.501178] Starting dynamic subtest: bcs0 [210.514917] Dynamic subtest bcs0: SUCCESS (0.032s) [210.526315] Starting dynamic subtest: vcs0 [210.543730] Dynamic subtest vcs0: SUCCESS (0.028s) [210.552244] Starting dynamic subtest: vcs1 [210.575529] Dynamic subtest vcs1: SUCCESS (0.031s) [210.583669] Starting dynamic subtest: vecs0 [210.605966] Dynamic subtest vecs0: SUCCESS (0.030s) [210.617449] Starting dynamic subtest: ccs0 [210.633844] Dynamic subtest ccs0: SUCCESS (0.028s) [210.636092] Subtest pi-common: SUCCESS (0.184s) [210.889300] [050/132] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [211.007678] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [211.012117] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [211.113271] [051/132] (808s left) kms_vrr (negative-basic) [211.213331] Starting subtest: negative-basic [211.220396] Starting dynamic subtest: pipe-A-eDP-1 [217.199130] Dynamic subtest pipe-A-eDP-1: FAIL (5.487s) [217.200884] Subtest negative-basic: FAIL (5.780s) [217.810490] [052/132] (802s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [217.914799] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [217.917137] Starting dynamic subtest: pipe-A-eDP-1 [218.000313] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s) [218.010213] Starting dynamic subtest: pipe-B-eDP-1 [219.231423] Dynamic subtest pipe-B-eDP-1: SKIP (1.197s) [219.236259] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.287s) [220.453850] [053/132] (799s left) dmabuf_sync_file (import-multiple-read-only) [220.523306] Starting subtest: import-multiple-read-only [220.525650] Subtest import-multiple-read-only: SUCCESS (0.005s) [220.605202] [054/132] (799s left) i915_pm_freq_api (freq-reset-multiple) [220.672322] Starting subtest: freq-reset-multiple [220.674731] Starting dynamic subtest: gt0 [230.354794] Dynamic subtest gt0: SUCCESS (9.517s) [230.362929] Starting dynamic subtest: gt1 [238.705992] Dynamic subtest gt1: SUCCESS (8.301s) [238.708343] Subtest freq-reset-multiple: SUCCESS (17.820s) [238.775905] [055/132] (781s left) prime_busy (before-wait) [238.851759] Starting subtest: before-wait [238.854289] Starting dynamic subtest: rcs0 [238.885534] Dynamic subtest rcs0: SUCCESS (0.031s) [238.895020] Starting dynamic subtest: bcs0 [238.927937] Dynamic subtest bcs0: SUCCESS (0.042s) [238.938271] Starting dynamic subtest: vcs0 [238.972446] Dynamic subtest vcs0: SUCCESS (0.044s) [238.985300] Starting dynamic subtest: vcs1 [239.015104] Dynamic subtest vcs1: SUCCESS (0.042s) [239.024432] Starting dynamic subtest: vecs0 [239.058458] Dynamic subtest vecs0: SUCCESS (0.043s) [239.067864] Starting dynamic subtest: ccs0 [239.101073] Dynamic subtest ccs0: SUCCESS (0.042s) [239.208570] Subtest before-wait: SUCCESS (0.355s) [239.292211] [056/132] (780s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [239.390524] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [239.394744] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [239.497226] [057/132] (780s left) api_intel_bb (object-reloc-purge-cache) [239.558457] Starting subtest: object-reloc-purge-cache [239.562606] Subtest object-reloc-purge-cache: SKIP (0.003s) [239.677478] [058/132] (780s left) gem_partial_pwrite_pread (write) [239.749762] Subtest write: SKIP (0.000s) [239.823022] [059/132] (780s left) kms_big_fb (y-tiled-16bpp-rotate-90) [239.922129] Starting subtest: y-tiled-16bpp-rotate-90 [239.926468] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [240.021495] [060/132] (780s left) gem_mmap_wc (write-prefaulted) [240.079096] Subtest write-prefaulted: SKIP (0.000s) [240.144819] [061/132] (780s left) gem_exec_balancer (waits) [240.209101] Starting subtest: waits [246.732254] Subtest waits: SUCCESS (6.506s) [247.047392] [062/132] (773s left) gem_ctx_persistence (heartbeat-hostile) [247.118013] Starting subtest: heartbeat-hostile [247.123008] Subtest heartbeat-hostile: SKIP (0.000s) [247.233455] [063/132] (773s left) kms_setmode (invalid-clone-single-crtc) [247.286580] Starting subtest: invalid-clone-single-crtc [247.293394] Subtest invalid-clone-single-crtc: SKIP (0.000s) [247.388404] [064/132] (773s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [247.489242] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [247.493563] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [247.581013] [065/132] (772s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [247.640687] Starting subtest: x-tiled-to-vebox-y-tiled [247.644987] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [247.835873] [066/132] (772s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [247.929030] Starting subtest: fbc-1p-pri-indfb-multidraw [260.703834] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.776s) [262.113166] [067/132] (758s left) kms_cursor_crc (cursor-rapid-movement-max-size) [262.443878] Starting subtest: cursor-rapid-movement-max-size [262.450660] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [262.587675] [068/132] (758s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt) [262.689263] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt [269.521354] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.832s) [269.657277] [069/132] (751s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [269.760084] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [270.761658] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.001s) [270.903026] [070/132] (749s left) perf (short-reads) [270.992749] Starting subtest: short-reads [271.004555] Subtest short-reads: SUCCESS (0.012s) [271.046380] [071/132] (749s left) gem_exec_schedule (thriceslice) [271.120665] Starting subtest: thriceslice [271.122611] Starting dynamic subtest: rcs0 [271.149750] Dynamic subtest rcs0: SUCCESS (0.029s) [271.161028] Starting dynamic subtest: bcs0 [271.178544] Dynamic subtest bcs0: SUCCESS (0.028s) [271.188129] Starting dynamic subtest: vcs0 [271.231456] Dynamic subtest vcs0: SUCCESS (0.051s) [271.242726] Starting dynamic subtest: vcs1 [271.282862] Dynamic subtest vcs1: SUCCESS (0.049s) [271.293821] Starting dynamic subtest: vecs0 [271.335306] Dynamic subtest vecs0: SUCCESS (0.050s) [271.346289] Starting dynamic subtest: ccs0 [271.389090] Dynamic subtest ccs0: SUCCESS (0.051s) [271.391556] Subtest thriceslice: SUCCESS (0.270s) [271.696384] [072/132] (749s left) i915_pm_rps (thresholds-park) [271.759617] Starting subtest: thresholds-park [271.763966] Subtest thresholds-park: SKIP (0.000s) [271.877302] [073/132] (749s left) syncobj_timeline (single-wait-for-submit-available-submitted) [271.927952] Starting subtest: single-wait-for-submit-available-submitted [271.930128] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [272.026214] [074/132] (748s left) gem_mmap_wc (write-read) [272.093661] Subtest write-read: SKIP (0.000s) [272.147175] [075/132] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [272.258495] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [272.263029] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [272.376564] [076/132] (748s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [272.472853] Starting subtest: plane-upscale-20x20-with-pixel-format [272.475132] Starting dynamic subtest: pipe-A [273.536569] Dynamic subtest pipe-A: SUCCESS (1.061s) [273.556441] Starting dynamic subtest: pipe-B [275.657274] Dynamic subtest pipe-B: SUCCESS (2.123s) [275.665298] Starting dynamic subtest: pipe-C [276.868611] Dynamic subtest pipe-C: SUCCESS (1.209s) [276.881192] Starting dynamic subtest: pipe-D [278.014985] Dynamic subtest pipe-D: SUCCESS (1.144s) [278.017282] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.543s) [279.214958] [077/132] (741s left) gem_userptr_blits (map-fixed-invalidate-busy) [279.272588] Starting subtest: map-fixed-invalidate-busy [279.277302] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [279.383653] [078/132] (741s left) gem_mmap_gtt (basic-small-bo-tiledx) [279.433502] Subtest basic-small-bo-tiledX: SKIP (0.000s) [279.492740] [079/132] (741s left) gem_exec_flush (basic-wb-ro-before-default) [279.559575] Starting subtest: basic-wb-ro-before-default [285.018310] Subtest basic-wb-ro-before-default: SUCCESS (5.457s) [285.212839] [080/132] (735s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [285.296027] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [285.300125] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [285.366582] [081/132] (735s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [285.478087] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [285.482248] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [285.592613] [082/132] (735s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [285.687471] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [289.791354] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.105s) [290.912366] [083/132] (730s left) kms_flip (wf_vblank-ts-check-interruptible) [290.998532] Starting subtest: wf_vblank-ts-check-interruptible [291.000732] Starting dynamic subtest: A-eDP1 [299.941805] Dynamic subtest A-eDP1: SUCCESS (8.937s) [299.954965] Starting dynamic subtest: B-eDP1 [308.879023] Dynamic subtest B-eDP1: SUCCESS (8.931s) [308.890785] Starting dynamic subtest: C-eDP1 [317.807898] Dynamic subtest C-eDP1: SUCCESS (8.926s) [317.818746] Starting dynamic subtest: D-eDP1 [326.729996] Dynamic subtest D-eDP1: SUCCESS (8.922s) [326.735294] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.729s) [327.949840] [084/132] (693s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [328.054920] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [328.057254] Starting dynamic subtest: pipe-A-eDP-1 [328.116625] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [328.127007] Starting dynamic subtest: pipe-B-eDP-1 [328.183946] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [328.193539] Starting dynamic subtest: pipe-C-eDP-1 [328.251422] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [328.261476] Starting dynamic subtest: pipe-D-eDP-1 [328.318645] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [328.322750] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s) [330.319326] [085/132] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [330.428988] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [330.433135] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [330.523719] [086/132] (690s left) kms_flip (absolute-wf_vblank-interruptible) [330.609214] Starting subtest: absolute-wf_vblank-interruptible [330.611527] Starting dynamic subtest: A-eDP1 [339.388093] Dynamic subtest A-eDP1: SUCCESS (8.778s) [339.397954] Starting dynamic subtest: B-eDP1 [348.116130] Dynamic subtest B-eDP1: SUCCESS (8.726s) [348.127560] Starting dynamic subtest: C-eDP1 [356.842146] Dynamic subtest C-eDP1: SUCCESS (8.722s) [356.852579] Starting dynamic subtest: D-eDP1 [365.570864] Dynamic subtest D-eDP1: SUCCESS (8.726s) [365.573223] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.962s) [366.784237] [087/132] (654s left) gem_lmem_swapping (heavy-verify-random) [366.825735] Subtest heavy-verify-random: SKIP (0.000s) [366.871007] [088/132] (654s left) perf_pmu (interrupts) [366.916753] Starting subtest: interrupts [368.006716] Subtest interrupts: SUCCESS (1.091s) [368.126202] [089/132] (653s left) kms_psr (psr2-cursor-render) [368.231249] Starting subtest: psr2-cursor-render [368.233592] Starting dynamic subtest: eDP-1 [369.955664] Dynamic subtest eDP-1: SUCCESS (1.724s) [369.958064] Subtest psr2-cursor-render: SUCCESS (1.725s) [370.754311] [090/132] (650s left) syncobj_wait (multi-wait-all-signaled) [370.805782] Starting subtest: multi-wait-all-signaled [370.807856] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [370.916641] [091/132] (650s left) gem_render_copy (y-tiled) [370.974550] Starting subtest: y-tiled [370.979136] Subtest y-tiled: SKIP (0.000s) [371.157622] [092/132] (650s left) kms_big_fb (x-tiled-32bpp-rotate-270) [371.250424] Starting subtest: x-tiled-32bpp-rotate-270 [371.271406] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s) [371.387572] [093/132] (650s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [371.484630] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [371.488883] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [371.591440] [094/132] (650s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [371.687134] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [371.689459] Starting dynamic subtest: pipe-A-eDP-1 [371.712358] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [371.723091] Starting dynamic subtest: pipe-B-eDP-1 [371.744629] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [371.753267] Starting dynamic subtest: pipe-C-eDP-1 [371.775236] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [371.783544] Starting dynamic subtest: pipe-D-eDP-1 [371.805574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [371.809991] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s) [374.004685] [095/132] (647s left) sysfs_defaults (readonly) [374.060965] Starting subtest: readonly [374.063412] Starting dynamic subtest: vecs0 [374.065815] Dynamic subtest vecs0: SUCCESS (0.000s) [374.076740] Starting dynamic subtest: ccs0 [374.078615] Dynamic subtest ccs0: SUCCESS (0.000s) [374.087674] Starting dynamic subtest: vcs0 [374.089921] Dynamic subtest vcs0: SUCCESS (0.000s) [374.098675] Starting dynamic subtest: bcs0 [374.100639] Dynamic subtest bcs0: SUCCESS (0.000s) [374.109105] Starting dynamic subtest: rcs0 [374.110981] Dynamic subtest rcs0: SUCCESS (0.000s) [374.119881] Starting dynamic subtest: vcs1 [374.121844] Dynamic subtest vcs1: SUCCESS (0.000s) [374.123758] Subtest readonly: SUCCESS (0.006s) [374.162147] [096/132] (647s left) kms_plane (plane-position-hole) [374.273031] Starting subtest: plane-position-hole [374.787812] Starting dynamic subtest: pipe-A-plane-1 [376.110603] Dynamic subtest pipe-A-plane-1: SUCCESS (1.320s) [376.120073] Starting dynamic subtest: pipe-A-plane-2 [377.427433] Dynamic subtest pipe-A-plane-2: SUCCESS (1.318s) [377.436804] Starting dynamic subtest: pipe-A-plane-3 [378.656661] Dynamic subtest pipe-A-plane-3: SUCCESS (1.225s) [378.675466] Starting dynamic subtest: pipe-A-plane-4 [379.901723] Dynamic subtest pipe-A-plane-4: SUCCESS (1.246s) [379.912105] Starting dynamic subtest: pipe-A-plane-5 [379.931468] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s) [381.165637] Starting dynamic subtest: pipe-B-plane-1 [382.487000] Dynamic subtest pipe-B-plane-1: SUCCESS (1.326s) [382.496859] Starting dynamic subtest: pipe-B-plane-2 [383.804657] Dynamic subtest pipe-B-plane-2: SUCCESS (1.318s) [383.813496] Starting dynamic subtest: pipe-B-plane-3 [385.055697] Dynamic subtest pipe-B-plane-3: SUCCESS (1.247s) [385.066348] Starting dynamic subtest: pipe-B-plane-4 [386.293908] Dynamic subtest pipe-B-plane-4: SUCCESS (1.238s) [386.304235] Starting dynamic subtest: pipe-B-plane-5 [386.317106] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [386.319297] Subtest plane-position-hole: SUCCESS (12.041s) [387.096608] [097/132] (634s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [387.196073] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [387.200218] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [387.288492] [098/132] (634s left) sw_sync (sync_merge_invalid) [387.328780] Starting subtest: sync_merge_invalid [387.339033] Subtest sync_merge_invalid: SUCCESS (0.014s) [387.407019] [099/132] (634s left) gem_gtt_cpu_tlb [387.535139] [100/132] (634s left) gem_softpin (allocator-evict) [387.594256] Starting subtest: allocator-evict [387.596617] Starting dynamic subtest: rcs0 [410.851062] Dynamic subtest rcs0: SUCCESS (23.252s) [410.861792] Starting dynamic subtest: bcs0 [434.992215] Dynamic subtest bcs0: SUCCESS (24.131s) [435.005141] Starting dynamic subtest: vcs0 [458.833921] Dynamic subtest vcs0: SUCCESS (23.843s) [458.844032] Starting dynamic subtest: vcs1 [482.609180] Dynamic subtest vcs1: SUCCESS (23.778s) [482.621791] Starting dynamic subtest: vecs0 [506.466802] Dynamic subtest vecs0: SUCCESS (23.855s) [506.478720] Starting dynamic subtest: ccs0 [530.054384] Dynamic subtest ccs0: SUCCESS (23.584s) [530.057021] Subtest allocator-evict: SUCCESS (142.452s) [530.136499] [101/132] (491s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [530.281967] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [530.284306] Starting dynamic subtest: pipe-A-eDP-1 [530.304919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [530.316626] Starting dynamic subtest: pipe-B-eDP-1 [530.336826] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [530.346119] Starting dynamic subtest: pipe-C-eDP-1 [530.365641] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [530.374852] Starting dynamic subtest: pipe-D-eDP-1 [530.394453] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [530.396655] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s) [532.473122] [102/132] (489s left) gem_eio (in-flight-immediate) [532.700128] Starting subtest: in-flight-immediate [540.679493] Subtest in-flight-immediate: SUCCESS (7.976s) [540.809724] [103/132] (481s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled) [540.876827] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [540.879156] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s) [540.952509] [104/132] (481s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [541.042221] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [541.044633] Starting dynamic subtest: pipe-A-default-mode [543.805425] Dynamic subtest pipe-A-default-mode: SUCCESS (2.761s) [543.807353] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.763s) [544.633234] [105/132] (477s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [544.736669] Starting subtest: psr2-plane-move-sf-dmg-area [544.738873] Starting dynamic subtest: pipe-A-eDP-1 [549.310935] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.576s) [549.321682] Starting dynamic subtest: pipe-B-eDP-1 [554.638878] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.324s) [554.641164] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.903s) [555.516689] [106/132] (466s left) kms_big_fb (linear-64bpp-rotate-270) [555.611233] Starting subtest: linear-64bpp-rotate-270 [555.630302] Subtest linear-64bpp-rotate-270: SKIP (0.018s) [555.745870] [107/132] (466s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [555.845837] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [555.848492] Starting dynamic subtest: pipe-A-eDP-1 [556.704430] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s) [556.714346] Starting dynamic subtest: pipe-B-eDP-1 [558.230859] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.525s) [558.240933] Starting dynamic subtest: pipe-C-eDP-1 [559.736263] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.503s) [559.746066] Starting dynamic subtest: pipe-D-eDP-1 [561.247002] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.511s) [561.249275] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.394s) [562.392976] [108/132] (459s left) sw_sync (alloc_merge_fence) [562.436400] Starting subtest: alloc_merge_fence [562.438533] Subtest alloc_merge_fence: SUCCESS (0.000s) [562.487047] [109/132] (459s left) i915_drm_fdinfo (most-busy-idle-check-all) [562.524757] Starting subtest: most-busy-idle-check-all [562.526752] Starting dynamic subtest: rcs0 [562.531560] Dynamic subtest rcs0: SKIP (0.003s) [562.543385] Starting dynamic subtest: bcs0 [562.547673] Dynamic subtest bcs0: SKIP (0.000s) [562.557148] Starting dynamic subtest: vcs0 [562.561116] Dynamic subtest vcs0: SKIP (0.000s) [562.569835] Starting dynamic subtest: vcs1 [562.573729] Dynamic subtest vcs1: SKIP (0.000s) [562.582818] Starting dynamic subtest: vecs0 [562.586694] Dynamic subtest vecs0: SKIP (0.000s) [562.595588] Starting dynamic subtest: ccs0 [562.599581] Dynamic subtest ccs0: SKIP (0.000s) [562.603493] Subtest most-busy-idle-check-all: SKIP (0.008s) [562.639377] [110/132] (459s left) kms_invalid_mode (zero-vdisplay) [562.744361] Starting subtest: zero-vdisplay [562.746527] Starting dynamic subtest: pipe-A-eDP-1 [563.039086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s) [563.049665] Starting dynamic subtest: pipe-B-eDP-1 [563.051568] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [563.061100] Starting dynamic subtest: pipe-C-eDP-1 [563.063243] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [563.072433] Starting dynamic subtest: pipe-D-eDP-1 [563.074683] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [563.076909] Subtest zero-vdisplay: SUCCESS (0.298s) [563.829866] [111/132] (458s left) kms_frontbuffer_tracking (fbc-tiling-y) [563.941928] Starting subtest: fbc-tiling-y [563.946518] Subtest fbc-tiling-y: SKIP (0.000s) [564.054609] [112/132] (458s left) kms_pm_rpm (fences-dpms) [566.010322] Starting subtest: fences-dpms [566.015197] Subtest fences-dpms: SKIP (0.000s) [566.389133] [113/132] (456s left) kms_cursor_edge_walk (64x64-top-edge) [566.476315] Starting subtest: 64x64-top-edge [566.478563] Starting dynamic subtest: pipe-A-eDP-1 [569.937588] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s) [569.948167] Starting dynamic subtest: pipe-D-eDP-1 [573.049310] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.109s) [573.051607] Subtest 64x64-top-edge: SUCCESS (6.571s) [573.860336] [114/132] (448s left) gem_exec_params (rs-invalid) [573.917766] Starting subtest: rs-invalid [573.922884] Subtest rs-invalid: SUCCESS (0.003s) [574.043679] [115/132] (448s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [574.153257] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [578.565427] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.415s) [579.761136] [116/132] (442s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [579.818150] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [579.820439] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s) [579.906947] [117/132] (442s left) kms_lease (empty-lease) [579.991350] Starting subtest: empty-lease [579.993550] Starting dynamic subtest: pipe-A-eDP-1 [579.995791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [580.005633] Starting dynamic subtest: pipe-B-eDP-1 [580.007488] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [580.016226] Starting dynamic subtest: pipe-C-eDP-1 [580.018108] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [580.027139] Starting dynamic subtest: pipe-D-eDP-1 [580.028941] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [580.030753] Subtest empty-lease: SUCCESS (0.009s) [580.097395] [118/132] (442s left) vgem_slow (nohang) [580.150689] Starting subtest: nohang [590.419127] Subtest nohang: SUCCESS (10.266s) [590.486153] [119/132] (432s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [590.537497] Starting subtest: etime-single-wait-available-unsubmitted [590.642138] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s) [590.719500] [120/132] (432s left) gen9_exec_parse (allowed-all) [590.774262] Subtest allowed-all: SKIP (0.000s) [590.839302] [121/132] (432s left) perf_pmu (init-wait) [590.888102] Starting subtest: init-wait [590.890391] Starting dynamic subtest: rcs0 [590.892632] Dynamic subtest rcs0: SUCCESS (0.002s) [590.903548] Starting dynamic subtest: bcs0 [590.905613] Dynamic subtest bcs0: SUCCESS (0.000s) [590.914524] Starting dynamic subtest: vcs0 [590.916588] Dynamic subtest vcs0: SUCCESS (0.001s) [590.928089] Starting dynamic subtest: vcs1 [590.930320] Dynamic subtest vcs1: SUCCESS (0.001s) [590.939361] Starting dynamic subtest: vecs0 [590.941938] Dynamic subtest vecs0: SUCCESS (0.001s) [590.950831] Starting dynamic subtest: ccs0 [590.952642] Dynamic subtest ccs0: SUCCESS (0.000s) [590.954475] Subtest init-wait: SUCCESS (0.008s) [591.014318] [122/132] (431s left) gem_render_copy (y-tiled-ccs-to-y-tiled) [591.069695] Starting subtest: y-tiled-ccs-to-y-tiled [591.074058] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s) [591.255352] [123/132] (431s left) gem_ccs (block-multicopy-inplace) [591.314438] Starting subtest: block-multicopy-inplace [591.318824] Subtest block-multicopy-inplace: SKIP (0.000s) [591.436447] [124/132] (431s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [591.534248] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [592.425989] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.892s) [592.588270] [125/132] (430s left) kms_sequence (get-forked-busy) [592.682237] Starting subtest: get-forked-busy [592.684559] Starting dynamic subtest: pipe-A-eDP-1 [594.617908] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [594.628479] Starting dynamic subtest: pipe-B-eDP-1 [597.239867] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.622s) [597.251480] Starting dynamic subtest: pipe-C-eDP-1 [599.850595] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s) [599.861832] Starting dynamic subtest: pipe-D-eDP-1 [602.407658] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s) [602.410087] Subtest get-forked-busy: SUCCESS (9.726s) [603.285571] [126/132] (419s left) gem_exec_create (basic) [603.353396] Starting subtest: basic [603.355795] Starting dynamic subtest: smem [605.441710] Dynamic subtest smem: SUCCESS (2.088s) [605.444396] Subtest basic: SUCCESS (2.089s) [605.623580] [127/132] (417s left) kms_feature_discovery (chamelium) [605.727357] Starting subtest: chamelium [605.731471] Subtest chamelium: SKIP (0.000s) [605.801686] [128/132] (417s left) kms_frontbuffer_tracking (fbc-suspend) [605.901378] Starting subtest: fbc-suspend [643.501211] Subtest fbc-suspend: SUCCESS (7.466s) [644.740617] [129/132] (378s left) kms_addfb_basic (basic) [644.814401] Starting subtest: basic [644.816753] Subtest basic: SUCCESS (0.000s) [644.967861] [130/132] (378s left) gem_exec_params (no-blt) [645.020571] Starting subtest: no-blt [645.025583] Subtest no-blt: SUCCESS (0.003s) [645.152255] [131/132] (378s left) kms_color (invalid-gamma-lut-sizes) [645.249195] Starting subtest: invalid-gamma-lut-sizes [645.251448] Starting dynamic subtest: pipe-A [645.549080] Dynamic subtest pipe-A: SUCCESS (0.293s) [645.558599] Starting dynamic subtest: pipe-B [645.560793] Dynamic subtest pipe-B: SUCCESS (0.000s) [645.570143] Starting dynamic subtest: pipe-C [645.572494] Dynamic subtest pipe-C: SUCCESS (0.000s) [645.583290] Starting dynamic subtest: pipe-D [645.585595] Dynamic subtest pipe-D: SUCCESS (0.000s) [645.587775] Subtest invalid-gamma-lut-sizes: SUCCESS (0.296s) [646.386069] [132/132] (376s left) gem_ctx_shared (exec-single-timeline) [646.448199] Starting subtest: exec-single-timeline [646.450617] Starting dynamic subtest: rcs0 [647.503245] Dynamic subtest rcs0: SUCCESS (1.033s) [647.516022] Starting dynamic subtest: bcs0 [648.589846] Dynamic subtest bcs0: SUCCESS (1.065s) [648.602783] Starting dynamic subtest: vcs0 [649.616877] Dynamic subtest vcs0: SUCCESS (1.011s) [649.630154] Starting dynamic subtest: vcs1 [650.702082] Dynamic subtest vcs1: SUCCESS (1.069s) [650.714598] Starting dynamic subtest: vecs0 [651.790722] Dynamic subtest vecs0: SUCCESS (1.073s) [651.803211] Starting dynamic subtest: ccs0 [652.878976] Dynamic subtest ccs0: SUCCESS (1.075s) [652.881762] Subtest exec-single-timeline: SUCCESS (6.343s) [653.926356] Closing watchdogs results: parsing output: 0/ for test: gem_exec_suspend results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_flip_scaled_crc results: parsing output: 5/ for test: kms_chamelium_edid results: parsing output: 6/ for test: kms_prop_blob results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: kms_vblank results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: kms_flip results: parsing output: 12/ for test: kms_chamelium_hpd results: parsing output: 13/ for test: kms_plane_alpha_blend results: parsing output: 14/ for test: kms_content_protection results: parsing output: 15/ for test: kms_cursor_crc results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: gem_ctx_isolation results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: api_intel_allocator results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_plane_multiple results: parsing output: 24/ for test: kms_addfb_basic results: parsing output: 25/ for test: i915_pm_rc6_residency results: parsing output: 26/ for test: syncobj_eventfd results: parsing output: 27/ for test: syncobj_basic results: parsing output: 28/ for test: gem_exec_balancer results: parsing output: 29/ for test: gem_userptr_blits results: parsing output: 30/ for test: gem_exec_reloc results: parsing output: 31/ for test: kms_addfb_basic results: parsing output: 32/ for test: perf results: parsing output: 33/ for test: kms_chamelium_color results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: tools_test results: parsing output: 36/ for test: gem_ctx_exec results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: kms_pm_rpm results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: gem_mmap_gtt results: parsing output: 41/ for test: gem_mmap_gtt results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_debugfs results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_fence results: parsing output: 47/ for test: gem_ringfill results: parsing output: 48/ for test: gem_exec_schedule results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_vrr results: parsing output: 51/ for test: kms_psr2_sf results: parsing output: 52/ for test: dmabuf_sync_file results: parsing output: 53/ for test: i915_pm_freq_api results: parsing output: 54/ for test: prime_busy results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: api_intel_bb results: parsing output: 57/ for test: gem_partial_pwrite_pread results: parsing output: 58/ for test: kms_big_fb results: parsing output: 59/ for test: gem_mmap_wc results: parsing output: 60/ for test: gem_exec_balancer results: parsing output: 61/ for test: gem_ctx_persistence results: parsing output: 62/ for test: kms_setmode results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_render_copy results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_cursor_crc results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_big_fb results: parsing output: 69/ for test: perf results: parsing output: 70/ for test: gem_exec_schedule results: parsing output: 71/ for test: i915_pm_rps results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: gem_mmap_wc results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_plane_scaling results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: gem_mmap_gtt results: parsing output: 78/ for test: gem_exec_flush results: parsing output: 79/ for test: kms_plane results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_flip results: parsing output: 86/ for test: gem_lmem_swapping results: parsing output: 87/ for test: perf_pmu results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: gem_render_copy results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: sysfs_defaults results: parsing output: 95/ for test: kms_plane results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: sw_sync results: parsing output: 98/ for test: gem_gtt_cpu_tlb results: parsing output: 99/ for test: gem_softpin results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: gem_eio results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: kms_flip_scaled_crc results: parsing output: 104/ for test: kms_psr2_sf results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: sw_sync results: parsing output: 108/ for test: i915_drm_fdinfo results: parsing output: 109/ for test: kms_invalid_mode results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_pm_rpm results: parsing output: 112/ for test: kms_cursor_edge_walk results: parsing output: 113/ for test: gem_exec_params results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: syncobj_timeline results: parsing output: 116/ for test: kms_lease results: parsing output: 117/ for test: vgem_slow results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: gen9_exec_parse results: parsing output: 120/ for test: perf_pmu results: parsing output: 121/ for test: gem_render_copy results: parsing output: 122/ for test: gem_ccs results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_sequence results: parsing output: 125/ for test: gem_exec_create results: parsing output: 126/ for test: kms_feature_discovery results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_addfb_basic results: parsing output: 129/ for test: gem_exec_params results: parsing output: 130/ for test: kms_color results: parsing output: 131/ for test: gem_ctx_shared Done.