[57.098714] Initializing watchdogs [57.098759] /dev/watchdog0 [57.112650] [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.117133] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.119546] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.122858] [001/131] (960s left) kms_pipe_crc_basic (suspend-read-crc) [57.247941] Starting subtest: suspend-read-crc [57.250333] Starting dynamic subtest: pipe-A-eDP-1 [75.003282] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.670s) [75.010957] Starting dynamic subtest: pipe-B-eDP-1 [93.026433] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.175s) [93.035750] Starting dynamic subtest: pipe-C-eDP-1 [110.950139] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.051s) [110.959114] Starting dynamic subtest: pipe-D-eDP-1 [128.967918] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.577s) [128.970296] Subtest suspend-read-crc: SUCCESS (12.476s) [129.760080] [002/131] (887s left) api_intel_allocator (fork-simple-stress) [129.821152] Starting subtest: fork-simple-stress [135.139547] Subtest fork-simple-stress: SUCCESS (5.398s) [135.205248] [003/131] (882s left) gem_exec_balancer (full-pulse) [135.282869] Starting subtest: full-pulse [140.214256] Subtest full-pulse: SUCCESS (4.991s) [140.528113] [004/131] (877s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [140.629154] Starting subtest: plane-use-after-nonblocking-unbind [140.631476] Starting dynamic subtest: pipe-A-eDP-1 [140.688916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s) [141.003567] Starting dynamic subtest: pipe-B-eDP-1 [141.767924] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.779s) [142.067249] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.447s) [142.931738] [005/131] (874s left) gem_exec_whisper (basic-queues-forked) [142.981801] Starting subtest: basic-queues-forked [167.478719] Subtest basic-queues-forked: SUCCESS (24.480s) [167.606635] [006/131] (850s left) kms_plane (plane-panning-bottom-right) [167.705220] Starting subtest: plane-panning-bottom-right [167.707726] Starting dynamic subtest: pipe-A [169.338373] Dynamic subtest pipe-A: SUCCESS (1.634s) [169.349097] Starting dynamic subtest: pipe-B [171.641240] Dynamic subtest pipe-B: SUCCESS (2.301s) [171.643603] Subtest plane-panning-bottom-right: SUCCESS (3.937s) [172.443227] [007/131] (845s left) kms_pm_rpm (dpms-non-lpsp) [174.603526] Starting subtest: dpms-non-lpsp [174.609339] Subtest dpms-non-lpsp: SKIP (0.001s) [174.979787] [008/131] (842s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [175.034556] Starting subtest: multi-wait-for-submit-submitted-signaled [175.036975] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [175.127411] [009/131] (842s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [175.233468] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [175.237476] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [175.358205] [010/131] (842s left) i915_module_load (resize-bar) [175.390696] Starting subtest: resize-bar [175.397113] Subtest resize-bar: SKIP (0.006s) [175.439839] [011/131] (842s left) gem_exec_flush (basic-uc-pro-default) [175.493668] Starting subtest: basic-uc-pro-default [180.981499] Subtest basic-uc-pro-default: SUCCESS (5.473s) [181.165696] [012/131] (836s left) gem_softpin (noreloc) [181.225811] Starting subtest: noreloc [186.664410] Subtest noreloc: SUCCESS (5.387s) [186.731658] [013/131] (831s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [186.848123] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [191.205388] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.361s) [192.403147] [014/131] (825s left) kms_setmode (basic-clone-single-crtc) [192.459105] Starting subtest: basic-clone-single-crtc [192.465358] Subtest basic-clone-single-crtc: SKIP (0.000s) [192.552730] [015/131] (825s left) gem_exec_fence (syncobj-timeline-chain-engines) [193.116434] Starting subtest: syncobj-timeline-chain-engines [193.220876] Subtest syncobj-timeline-chain-engines: SUCCESS (0.104s) [194.451673] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [194.455276] [016/131] (823s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [194.546801] Starting subtest: fbc-rgb565-draw-pwrite [199.036349] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.494s) [200.196809] [017/131] (818s left) kms_pm_rpm (pc8-residency) [201.719918] Starting subtest: pc8-residency [201.724880] Subtest pc8-residency: SKIP (0.000s) [202.437760] [018/131] (815s left) kms_psr (fbc-psr-cursor-mmap-cpu) [202.527177] Starting subtest: fbc-psr-cursor-mmap-cpu [202.529386] Starting dynamic subtest: eDP-1 [202.533583] Dynamic subtest eDP-1: SKIP (0.000s) [202.537700] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [202.602420] [019/131] (815s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [202.692543] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [202.694906] Starting dynamic subtest: A-eDP1 [206.356792] Dynamic subtest A-eDP1: SUCCESS (3.668s) [206.366294] Starting dynamic subtest: B-eDP1 [209.540798] Dynamic subtest B-eDP1: SUCCESS (3.182s) [209.551316] Starting dynamic subtest: C-eDP1 [212.633917] Dynamic subtest C-eDP1: SUCCESS (3.095s) [212.643476] Starting dynamic subtest: D-eDP1 [215.733032] Dynamic subtest D-eDP1: SUCCESS (3.099s) [215.735393] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.050s) [216.547747] [020/131] (801s left) gem_softpin (noreloc-s3) [216.620348] Starting subtest: noreloc-S3 [237.118713] Subtest noreloc-S3: SUCCESS (5.390s) [237.277134] [021/131] (781s left) gem_userptr_blits (map-fixed-invalidate) [237.346102] Starting subtest: map-fixed-invalidate [237.350887] Subtest map-fixed-invalidate: SKIP (0.000s) [237.474626] [022/131] (780s left) gem_ccs (large-ctrl-surf-copy) [237.521042] Starting subtest: large-ctrl-surf-copy [237.525102] Subtest large-ctrl-surf-copy: SKIP (0.000s) [237.638904] [023/131] (780s left) gem_exec_params (invalid-flag) [237.695047] Starting subtest: invalid-flag [237.697525] Subtest invalid-flag: SUCCESS (0.000s) [237.784545] [024/131] (780s left) kms_dither (fb-8bpc-vs-panel-8bpc) [237.888928] Starting subtest: fb-8bpc-vs-panel-8bpc [237.891195] Starting dynamic subtest: pipe-A-eDP-1 [239.328801] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.467s) [239.331038] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.470s) [240.167203] [025/131] (778s left) gem_exec_reloc (basic-range-active) [240.231867] Subtest basic-range-active: SKIP (0.000s) [240.305608] [026/131] (778s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier) [240.394119] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier [240.398301] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s) [240.466455] [027/131] (778s left) prime_mmap (test_map_unmap) [240.523161] Starting subtest: test_map_unmap [240.525416] Starting dynamic subtest: test_map_unmap-smem [240.551094] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s) [240.553523] Subtest test_map_unmap: SUCCESS (0.031s) [240.647590] [028/131] (778s left) gem_vm_create (create-ext) [240.709582] Starting subtest: create-ext [240.713957] Subtest create-ext: SUCCESS (0.005s) [240.819873] [029/131] (777s left) kms_atomic (plane-immutable-zpos) [240.903401] Starting subtest: plane-immutable-zpos [240.905279] Starting dynamic subtest: pipe-A-eDP-1 [241.541490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.646s) [241.543595] Subtest plane-immutable-zpos: SUCCESS (0.647s) [242.367680] [030/131] (776s left) kms_cursor_crc (cursor-rapid-movement-512x170) [242.645964] Starting subtest: cursor-rapid-movement-512x170 [242.650375] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [242.805688] [031/131] (776s left) syncobj_timeline (multi-wait-for-submit-signaled) [242.859376] Starting subtest: multi-wait-for-submit-signaled [242.861733] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [242.980739] [032/131] (775s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [243.068141] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [243.070447] Starting dynamic subtest: pipe-A-eDP-1 [275.357775] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.860s) [275.366828] Starting dynamic subtest: pipe-B-eDP-1 [308.346029] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.861s) [308.355478] Starting dynamic subtest: pipe-C-eDP-1 [341.248973] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.614s) [341.257992] Starting dynamic subtest: pipe-D-eDP-1 [374.274560] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.694s) [374.276876] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.033s) [375.472432] [033/131] (643s left) gem_exec_schedule (preempt) [375.551797] Starting subtest: preempt [375.553965] Starting dynamic subtest: rcs0 [375.567833] Dynamic subtest rcs0: SUCCESS (0.024s) [375.578380] Starting dynamic subtest: bcs0 [375.584752] Dynamic subtest bcs0: SUCCESS (0.017s) [375.594198] Starting dynamic subtest: vcs0 [375.603771] Dynamic subtest vcs0: SUCCESS (0.019s) [375.613422] Starting dynamic subtest: vcs1 [375.623212] Dynamic subtest vcs1: SUCCESS (0.019s) [375.632784] Starting dynamic subtest: vecs0 [375.643177] Dynamic subtest vecs0: SUCCESS (0.020s) [375.652390] Starting dynamic subtest: ccs0 [375.662125] Dynamic subtest ccs0: SUCCESS (0.019s) [375.664376] Subtest preempt: SUCCESS (0.121s) [377.316718] [034/131] (641s left) kms_chamelium_hpd (hdmi-hpd-storm) [377.695557] Subtest hdmi-hpd-storm: SKIP (0.000s) [378.524754] [035/131] (640s left) gem_exec_params (invalid-ring) [378.598829] Starting subtest: invalid-ring [378.601175] Subtest invalid-ring: SUCCESS (0.000s) [378.705365] [036/131] (640s left) kms_cursor_crc (cursor-sliding-32x32) [378.857096] Starting subtest: cursor-sliding-32x32 [378.900556] Subtest cursor-sliding-32x32: SKIP (0.039s) [379.177038] [037/131] (639s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [379.267174] Starting subtest: psr-rgb101010-draw-render [386.431201] Subtest psr-rgb101010-draw-render: SUCCESS (7.230s) [386.542221] [038/131] (632s left) sysfs_timeslice_duration (idempotent) [386.600570] Starting subtest: idempotent [386.602899] Starting dynamic subtest: vecs0 [386.605119] Dynamic subtest vecs0: SUCCESS (0.000s) [386.615829] Starting dynamic subtest: ccs0 [386.618035] Dynamic subtest ccs0: SUCCESS (0.000s) [386.626604] Starting dynamic subtest: vcs0 [386.628446] Dynamic subtest vcs0: SUCCESS (0.000s) [386.637086] Starting dynamic subtest: bcs0 [386.639006] Dynamic subtest bcs0: SUCCESS (0.000s) [386.647341] Starting dynamic subtest: rcs0 [386.649675] Dynamic subtest rcs0: SUCCESS (0.000s) [386.658183] Starting dynamic subtest: vcs1 [386.660475] Dynamic subtest vcs1: SUCCESS (0.000s) [386.662657] Subtest idempotent: SUCCESS (0.006s) [386.721860] [039/131] (632s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs) [386.821777] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs [386.824025] Starting dynamic subtest: pipe-A-eDP-1 [386.846601] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [386.861920] Starting dynamic subtest: pipe-B-eDP-1 [386.883279] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [386.892756] Starting dynamic subtest: pipe-C-eDP-1 [386.913647] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [386.922811] Starting dynamic subtest: pipe-D-eDP-1 [386.944811] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [386.948799] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s) [389.062374] [040/131] (630s left) kms_content_protection (uevent) [389.210361] Starting subtest: uevent [389.214760] Subtest uevent: SKIP (0.000s) [389.327243] [041/131] (629s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [389.437416] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [390.456865] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.023s) [390.580824] [042/131] (628s left) perf (invalid-remove-userspace-config) [390.702939] Starting subtest: invalid-remove-userspace-config [390.707953] Subtest invalid-remove-userspace-config: SUCCESS (0.007s) [390.751069] [043/131] (628s left) gem_exec_parallel (engines) [390.805609] Starting subtest: engines [390.807595] Starting dynamic subtest: basic [392.269183] Dynamic subtest basic: SUCCESS (1.466s) [392.281085] Starting dynamic subtest: contexts [396.584768] Dynamic subtest contexts: SUCCESS (4.322s) [396.599386] Starting dynamic subtest: fds [400.356937] Dynamic subtest fds: SUCCESS (3.775s) [400.369226] Starting dynamic subtest: userptr [402.202037] Dynamic subtest userptr: SUCCESS (1.845s) [402.205081] Subtest engines: SUCCESS (11.417s) [402.396277] [044/131] (616s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [402.506337] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [402.532066] Starting dynamic subtest: pipe-A-plane-0 [402.820865] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [402.832699] Starting dynamic subtest: pipe-A-plane-3 [403.064563] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s) [404.209841] Starting dynamic subtest: pipe-B-plane-0 [404.512115] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s) [404.522235] Starting dynamic subtest: pipe-B-plane-3 [404.743411] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s) [405.062162] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.564s) [405.873774] [045/131] (613s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [405.925011] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [405.929035] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [406.108980] [046/131] (613s left) gem_mmap_offset (bad-object) [406.168681] Starting subtest: bad-object [406.170947] Subtest bad-object: SUCCESS (0.001s) [406.287584] [047/131] (613s left) i915_suspend (basic-s2idle-without-i915) [406.320682] Starting subtest: basic-s2idle-without-i915 [427.509377] Subtest basic-s2idle-without-i915: SUCCESS (5.653s) [427.617952] [048/131] (591s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [427.723680] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [427.727621] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [427.821942] [049/131] (591s left) gem_pxp (regular-baseline-src-copy-readible) [427.948603] Starting subtest: regular-baseline-src-copy-readible [428.009498] Subtest regular-baseline-src-copy-readible: SUCCESS (0.066s) [428.112280] [050/131] (591s left) kms_flip (plain-flip-fb-recreate) [428.207947] Starting subtest: plain-flip-fb-recreate [428.209785] Starting dynamic subtest: A-eDP1 [448.821603] Dynamic subtest A-eDP1: SUCCESS (20.847s) [448.833000] Starting dynamic subtest: B-eDP1 [457.721378] Dynamic subtest B-eDP1: SUCCESS (8.913s) [457.734090] Starting dynamic subtest: C-eDP1 [466.540957] Dynamic subtest C-eDP1: SUCCESS (8.825s) [466.551879] Starting dynamic subtest: D-eDP1 [475.373316] Dynamic subtest D-eDP1: SUCCESS (8.836s) [475.377486] Subtest plain-flip-fb-recreate: SUCCESS (47.432s) [476.551649] [051/131] (543s left) gem_workarounds (reset-context) [476.618184] Starting subtest: reset-context [476.719718] Subtest reset-context: SUCCESS (0.102s) [476.855796] [052/131] (542s left) gen9_exec_parse (valid-registers) [476.913547] Subtest valid-registers: SKIP (0.000s) [476.983958] [053/131] (542s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [477.033453] Starting subtest: etime-single-wait-all-available-unsubmitted [477.134018] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.102s) [477.211831] [054/131] (542s left) syncobj_timeline (single-wait-for-submit-signaled) [477.263907] Starting subtest: single-wait-for-submit-signaled [477.266165] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [477.360552] [055/131] (542s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [477.457413] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [478.444319] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.989s) [478.628530] [056/131] (541s left) gem_ctx_persistence (engines-queued) [478.692611] Starting subtest: engines-queued [478.694445] Starting dynamic subtest: rcs0 [478.780163] Dynamic subtest rcs0: SUCCESS (0.087s) [478.792454] Starting dynamic subtest: bcs0 [478.818943] Dynamic subtest bcs0: SUCCESS (0.037s) [478.829095] Starting dynamic subtest: vcs0 [480.813225] Dynamic subtest vcs0: SUCCESS (1.992s) [480.826619] Starting dynamic subtest: vcs1 [482.791447] Dynamic subtest vcs1: SUCCESS (1.977s) [482.801889] Starting dynamic subtest: vecs0 [484.778418] Dynamic subtest vecs0: SUCCESS (1.985s) [484.792193] Starting dynamic subtest: ccs0 [484.953081] Dynamic subtest ccs0: SUCCESS (0.174s) [484.955491] Subtest engines-queued: SUCCESS (6.264s) [485.066871] [057/131] (534s left) kms_flip (basic-flip-vs-dpms) [485.174615] Starting subtest: basic-flip-vs-dpms [485.177062] Starting dynamic subtest: A-eDP1 [487.747497] Dynamic subtest A-eDP1: SUCCESS (2.575s) [487.757410] Starting dynamic subtest: B-eDP1 [489.917921] Dynamic subtest B-eDP1: SUCCESS (2.167s) [489.927172] Starting dynamic subtest: C-eDP1 [491.994881] Dynamic subtest C-eDP1: SUCCESS (2.076s) [492.004465] Starting dynamic subtest: D-eDP1 [494.065995] Dynamic subtest D-eDP1: SUCCESS (2.070s) [494.068212] Subtest basic-flip-vs-dpms: SUCCESS (8.902s) [494.873226] [058/131] (525s left) core_sysfs (read-all-entries) [494.936862] Starting subtest: read-all-entries [494.939138] Subtest read-all-entries: SUCCESS (0.003s) [495.039462] [059/131] (524s left) gem_linear_blits (basic) [495.493466] Starting subtest: basic [495.500960] Subtest basic: SUCCESS (0.009s) [495.635318] [060/131] (524s left) kms_cursor_crc (cursor-onscreen-32x32) [495.831100] Starting subtest: cursor-onscreen-32x32 [495.876453] Subtest cursor-onscreen-32x32: SKIP (0.040s) [496.176524] [061/131] (523s left) gem_softpin (noreloc-interruptible) [496.252348] Starting subtest: noreloc-interruptible [501.716427] Subtest noreloc-interruptible: SUCCESS (5.415s) [501.783925] [062/131] (518s left) gem_exec_whisper (basic-forked-all) [501.858468] Starting subtest: basic-forked-all [517.838811] Subtest basic-forked-all: SUCCESS (15.986s) [518.025266] [063/131] (502s left) kms_universal_plane (universal-plane-pageflip-windowed) [518.124091] Starting subtest: universal-plane-pageflip-windowed [518.126042] Starting dynamic subtest: pipe-A-eDP-1 [518.726250] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s) [518.737281] Starting dynamic subtest: pipe-B-eDP-1 [519.983016] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s) [519.993010] Starting dynamic subtest: pipe-C-eDP-1 [521.189849] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s) [521.199801] Starting dynamic subtest: pipe-D-eDP-1 [522.425116] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s) [522.427864] Subtest universal-plane-pageflip-windowed: SUCCESS (4.301s) [523.288721] [064/131] (496s left) syncobj_wait (wait-all-complex) [523.352612] Starting subtest: wait-all-complex [523.568929] Subtest wait-all-complex: SUCCESS (0.214s) [523.658163] [065/131] (496s left) perf_pmu (semaphore-wait-idle) [523.699791] Starting subtest: semaphore-wait-idle [523.702248] Starting dynamic subtest: rcs0 [524.216703] Dynamic subtest rcs0: SUCCESS (0.514s) [524.228422] Starting dynamic subtest: bcs0 [524.731876] Dynamic subtest bcs0: SUCCESS (0.510s) [524.744829] Starting dynamic subtest: vcs0 [525.246645] Dynamic subtest vcs0: SUCCESS (0.510s) [525.259743] Starting dynamic subtest: vcs1 [525.760358] Dynamic subtest vcs1: SUCCESS (0.511s) [525.772631] Starting dynamic subtest: vecs0 [526.278381] Dynamic subtest vecs0: SUCCESS (0.514s) [526.290209] Starting dynamic subtest: ccs0 [526.796770] Dynamic subtest ccs0: SUCCESS (0.514s) [526.799625] Subtest semaphore-wait-idle: SUCCESS (3.089s) [527.891794] [066/131] (492s left) gem_exec_params (rsvd2-dirt) [527.958917] Starting subtest: rsvd2-dirt [527.963805] Subtest rsvd2-dirt: SKIP (0.000s) [528.075055] [067/131] (492s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [528.173413] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [529.232894] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.057s) [529.354801] [068/131] (491s left) kms_chamelium_color (ctm-0-75) [529.447924] Subtest ctm-0-75: SKIP (0.000s) [529.491876] [069/131] (490s left) gem_mmap_gtt (fault-concurrent-x) [529.554129] Subtest fault-concurrent-X: SKIP (0.000s) [529.613270] [070/131] (490s left) kms_psr (pr-primary-render) [529.698585] Starting subtest: pr-primary-render [529.701875] Subtest pr-primary-render: SKIP (0.000s) [529.769539] [071/131] (490s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [529.857580] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [529.861316] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [529.955999] [072/131] (490s left) perf_pmu (idle) [530.001414] Starting subtest: idle [530.003294] Starting dynamic subtest: rcs0 [530.544623] Dynamic subtest rcs0: SUCCESS (0.541s) [530.561556] Starting dynamic subtest: bcs0 [531.060616] Dynamic subtest bcs0: SUCCESS (0.512s) [531.074713] Starting dynamic subtest: vcs0 [531.578619] Dynamic subtest vcs0: SUCCESS (0.514s) [531.590139] Starting dynamic subtest: vcs1 [532.093675] Dynamic subtest vcs1: SUCCESS (0.512s) [532.104598] Starting dynamic subtest: vecs0 [532.613644] Dynamic subtest vecs0: SUCCESS (0.516s) [532.625227] Starting dynamic subtest: ccs0 [533.128415] Dynamic subtest ccs0: SUCCESS (0.511s) [533.131162] Subtest idle: SUCCESS (3.122s) [533.233757] [073/131] (487s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [533.339474] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [533.341335] Starting dynamic subtest: pipe-A-eDP-1 [534.186563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.839s) [534.200506] Starting dynamic subtest: pipe-B-eDP-1 [535.746844] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.555s) [535.757948] Starting dynamic subtest: pipe-C-eDP-1 [537.247584] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.498s) [537.258412] Starting dynamic subtest: pipe-D-eDP-1 [538.748205] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.499s) [538.750199] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.395s) [539.955803] [074/131] (480s left) gem_exec_fence (basic-busy) [540.140776] Starting subtest: basic-busy [540.143436] Starting dynamic subtest: rcs0 [540.215162] Dynamic subtest rcs0: SUCCESS (0.074s) [540.230485] Starting dynamic subtest: bcs0 [540.273221] Dynamic subtest bcs0: SUCCESS (0.056s) [540.285156] Starting dynamic subtest: vcs0 [540.327576] Dynamic subtest vcs0: SUCCESS (0.052s) [540.340428] Starting dynamic subtest: vcs1 [540.384830] Dynamic subtest vcs1: SUCCESS (0.055s) [540.395803] Starting dynamic subtest: vecs0 [540.441982] Dynamic subtest vecs0: SUCCESS (0.055s) [540.454375] Starting dynamic subtest: ccs0 [540.494186] Dynamic subtest ccs0: SUCCESS (0.050s) [540.497127] Subtest basic-busy: SUCCESS (0.354s) [541.930598] [075/131] (478s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [542.027994] Starting subtest: fbc-pr-cursor-plane-update-sf [542.032359] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s) [542.103980] [076/131] (478s left) gem_pxp (create-regular-context-1) [542.160678] Starting subtest: create-regular-context-1 [542.162907] Subtest create-regular-context-1: SUCCESS (0.001s) [542.279121] [077/131] (478s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [542.401890] Starting subtest: cursorB-vs-flipA-atomic-transitions [542.406207] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s) [542.545621] [078/131] (478s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [542.651873] Starting subtest: basic-busy-flip-before-cursor-atomic [542.656501] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [542.799804] [079/131] (478s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [542.905961] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [549.447731] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.541s) [549.558749] [080/131] (471s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [549.668975] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [550.482938] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.814s) [550.634233] [081/131] (470s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [550.744647] Starting subtest: fbcpsr-tiling-y [550.748852] Subtest fbcpsr-tiling-y: SKIP (0.000s) [550.848808] [082/131] (470s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [550.949081] Starting subtest: addfb25-yf-tiled-legacy [550.951376] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [551.041858] [083/131] (469s left) kms_frontbuffer_tracking (psr-1p-rte) [551.132823] Starting subtest: psr-1p-rte [556.497751] Subtest psr-1p-rte: SUCCESS (5.367s) [556.658902] [084/131] (464s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [556.753207] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [556.755460] Starting dynamic subtest: pipe-A-eDP-1 [556.812355] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [556.822014] Starting dynamic subtest: pipe-B-eDP-1 [556.879819] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [556.892084] Starting dynamic subtest: pipe-C-eDP-1 [556.951916] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [556.963035] Starting dynamic subtest: pipe-D-eDP-1 [557.019359] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [557.023784] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s) [558.919107] [085/131] (462s left) kms_lease (setcrtc-implicit-plane) [559.006908] Starting subtest: setcrtc-implicit-plane [559.009357] Starting dynamic subtest: pipe-A-eDP-1 [559.478113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.470s) [559.488256] Starting dynamic subtest: pipe-B-eDP-1 [560.662062] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.184s) [560.674098] Starting dynamic subtest: pipe-C-eDP-1 [561.748786] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.085s) [561.765711] Starting dynamic subtest: pipe-D-eDP-1 [562.884636] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s) [562.886794] Subtest setcrtc-implicit-plane: SUCCESS (3.878s) [563.726001] [086/131] (457s left) kms_tv_load_detect (load-detect) [563.792923] Subtest load-detect: SKIP (0.000s) [563.855351] [087/131] (457s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [563.948880] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [563.953169] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [564.054509] [088/131] (457s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [564.138242] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [564.140724] Starting dynamic subtest: pipe-A [564.161266] Dynamic subtest pipe-A: SKIP (0.017s) [564.171880] Starting dynamic subtest: pipe-B [564.192625] Dynamic subtest pipe-B: SKIP (0.030s) [564.202740] Starting dynamic subtest: pipe-C [564.222631] Dynamic subtest pipe-C: SKIP (0.030s) [564.232577] Starting dynamic subtest: pipe-D [564.252443] Dynamic subtest pipe-D: SKIP (0.030s) [564.256879] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.110s) [564.344321] [089/131] (456s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [564.441623] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [570.943951] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.503s) [571.085113] [090/131] (450s left) syncobj_wait (wait-all-for-submit-snapshot) [571.144870] Starting subtest: wait-all-for-submit-snapshot [571.225752] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [571.316314] [091/131] (450s left) kms_flip (flip-vs-dpms-off-vs-modeset) [571.427948] Starting subtest: flip-vs-dpms-off-vs-modeset [571.430232] Starting dynamic subtest: A-eDP1 [575.099599] Dynamic subtest A-eDP1: SUCCESS (3.672s) [575.110120] Starting dynamic subtest: B-eDP1 [578.316500] Dynamic subtest B-eDP1: SUCCESS (3.216s) [578.326617] Starting dynamic subtest: C-eDP1 [581.407372] Dynamic subtest C-eDP1: SUCCESS (3.090s) [581.419153] Starting dynamic subtest: D-eDP1 [584.505081] Dynamic subtest D-eDP1: SUCCESS (3.095s) [584.507531] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.081s) [585.309314] [092/131] (436s left) gem_busy (busy) [585.371449] Starting subtest: busy [585.373777] Starting dynamic subtest: all-engines [585.425734] Dynamic subtest all-engines: SUCCESS (0.054s) [585.436888] Starting dynamic subtest: rcs0 [586.835353] Dynamic subtest rcs0: SUCCESS (1.407s) [586.847239] Starting dynamic subtest: bcs0 [586.875413] Dynamic subtest bcs0: SUCCESS (0.038s) [586.885372] Starting dynamic subtest: vcs0 [586.914174] Dynamic subtest vcs0: SUCCESS (0.038s) [586.923965] Starting dynamic subtest: vcs1 [588.817073] Dynamic subtest vcs1: SUCCESS (1.898s) [588.828432] Starting dynamic subtest: vecs0 [590.918197] Dynamic subtest vecs0: SUCCESS (2.045s) [590.930602] Starting dynamic subtest: ccs0 [592.849217] Dynamic subtest ccs0: SUCCESS (1.984s) [592.851328] Subtest busy: SUCCESS (7.474s) [593.215605] [093/131] (428s left) api_intel_bb (object-noreloc-purge-cache-simple) [593.278293] Starting subtest: object-noreloc-purge-cache-simple [593.284663] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.009s) [593.437564] [094/131] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [593.537486] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [593.541525] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [593.655191] [095/131] (427s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [593.741435] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [600.740835] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.000s) [600.857560] [096/131] (420s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [600.958648] Starting subtest: pr-plane-move-sf-dmg-area [600.962457] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [601.026283] [097/131] (420s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [601.122520] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [601.126644] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [601.234186] [098/131] (420s left) gem_userptr_blits (sync-unmap) [601.305752] Starting subtest: sync-unmap [601.316804] Subtest sync-unmap: SUCCESS (0.013s) [601.441841] [099/131] (420s left) syncobj_timeline (multi-wait-all-available-signaled) [601.488804] Starting subtest: multi-wait-all-available-signaled [601.491056] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [601.586025] [100/131] (420s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [601.674443] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [601.676638] Starting dynamic subtest: pipe-A-default-mode [602.805878] Dynamic subtest pipe-A-default-mode: SKIP (1.130s) [602.809960] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.131s) [602.952805] [101/131] (418s left) gem_ctx_param (invalid-size-set) [603.007266] Starting subtest: invalid-size-set [603.009928] Subtest invalid-size-set: SUCCESS (0.001s) [603.122343] [102/131] (418s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [603.245966] Starting subtest: basic-flip-before-cursor-atomic [604.164763] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.916s) [605.013743] [103/131] (416s left) i915_pm_rpm (gem-execbuf-stress) [607.036838] Starting subtest: gem-execbuf-stress [607.040034] Starting dynamic subtest: smem0 [619.881780] Dynamic subtest smem0: SUCCESS (12.843s) [619.895265] Starting dynamic subtest: extra-wait-smem0 [681.657084] Dynamic subtest extra-wait-smem0: SUCCESS (61.771s) [681.660106] Subtest gem-execbuf-stress: SUCCESS (74.620s) [682.027218] [104/131] (339s left) gem_exec_reloc (basic-write-gtt) [682.086682] Subtest basic-write-gtt: SKIP (0.000s) [682.143019] [105/131] (339s left) gem_spin_batch (spin-all-new) [682.214510] Starting subtest: spin-all-new [682.227868] Subtest spin-all-new: SUCCESS (0.016s) [683.891677] [106/131] (338s left) kms_vblank (wait-busy) [684.001776] Starting subtest: wait-busy [684.004202] Starting dynamic subtest: pipe-A-eDP-1 [685.893425] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s) [685.909445] Starting dynamic subtest: pipe-D-eDP-1 [688.485870] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s) [688.488108] Subtest wait-busy: SUCCESS (4.483s) [689.293205] [107/131] (332s left) kms_invalid_mode (bad-htotal) [689.396224] Starting subtest: bad-htotal [689.398627] Starting dynamic subtest: pipe-A-eDP-1 [689.679472] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [689.691283] Starting dynamic subtest: pipe-B-eDP-1 [689.693263] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [689.704458] Starting dynamic subtest: pipe-C-eDP-1 [689.706569] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [689.716131] Starting dynamic subtest: pipe-D-eDP-1 [689.718438] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [689.720601] Subtest bad-htotal: SUCCESS (0.292s) [690.501430] [108/131] (331s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [690.595505] Starting subtest: fbcpsr-modesetfrombusy [696.788674] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.197s) [696.918525] [109/131] (325s left) gen9_exec_parse (allowed-all) [696.973015] Subtest allowed-all: SKIP (0.000s) [697.036939] [110/131] (325s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [697.135987] Starting subtest: psr2-overlay-plane-update-continuous-sf [697.138075] Starting dynamic subtest: pipe-A-eDP-1 [698.243008] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.109s) [698.252890] Starting dynamic subtest: pipe-B-eDP-1 [699.999018] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.756s) [700.001354] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.868s) [700.809224] [111/131] (321s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [700.869905] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [700.975541] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.105s) [701.052835] [112/131] (321s left) gem_ctx_persistence (heartbeat-close) [701.118728] Starting subtest: heartbeat-close [701.123058] Subtest heartbeat-close: SKIP (0.000s) [701.217825] [113/131] (321s left) gem_exec_params (invalid-bsd2-flag-on-blt) [701.279036] Starting subtest: invalid-bsd2-flag-on-blt [701.281414] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s) [701.387568] [114/131] (320s left) kms_psr (psr2-no-drrs) [701.481106] Starting subtest: psr2-no-drrs [701.483490] Starting dynamic subtest: eDP-1 [703.078462] Dynamic subtest eDP-1: SUCCESS (1.598s) [703.080668] Subtest psr2-no-drrs: SUCCESS (1.599s) [703.879453] [115/131] (318s left) kms_psr (psr-cursor-render) [703.971934] Starting subtest: psr-cursor-render [703.974098] Starting dynamic subtest: eDP-1 [705.669407] Dynamic subtest eDP-1: SUCCESS (1.699s) [705.671969] Subtest psr-cursor-render: SUCCESS (1.700s) [706.550759] [116/131] (315s left) kms_dsc (dsc-fractional-bpp) [706.646915] Starting subtest: dsc-fractional-bpp [706.660109] Subtest dsc-fractional-bpp: SKIP (0.000s) [706.734558] [117/131] (315s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [706.854863] Starting subtest: flip-vs-cursor-atomic-transitions [714.735633] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.881s) [715.592925] [118/131] (306s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [715.698560] Starting subtest: fbc-rgb101010-draw-mmap-cpu [720.282452] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.587s) [721.393418] [119/131] (301s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [721.484659] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [721.489273] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [721.578304] [120/131] (301s left) perf_pmu (interrupts) [721.619578] Starting subtest: interrupts [722.691578] Subtest interrupts: SUCCESS (1.071s) [722.817617] [121/131] (299s left) syncobj_wait (wait-all-for-submit-delayed-submit) [722.872543] Starting subtest: wait-all-for-submit-delayed-submit [722.976355] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [723.064729] [122/131] (299s left) perf_pmu (busy-accuracy-50) [723.108815] Starting subtest: busy-accuracy-50 [723.111150] Starting dynamic subtest: rcs0 [724.645644] Dynamic subtest rcs0: SUCCESS (1.537s) [724.658090] Starting dynamic subtest: bcs0 [726.194639] Dynamic subtest bcs0: SUCCESS (1.547s) [726.207366] Starting dynamic subtest: vcs0 [727.735698] Dynamic subtest vcs0: SUCCESS (1.538s) [727.747590] Starting dynamic subtest: vcs1 [729.275459] Dynamic subtest vcs1: SUCCESS (1.539s) [729.288267] Starting dynamic subtest: vecs0 [730.815281] Dynamic subtest vecs0: SUCCESS (1.538s) [730.825738] Starting dynamic subtest: ccs0 [732.366109] Dynamic subtest ccs0: SUCCESS (1.548s) [732.368633] Subtest busy-accuracy-50: SUCCESS (9.258s) [732.481748] [123/131] (290s left) kms_color_pipeline (plane-ctm3x4) [732.588432] Starting subtest: plane-ctm3x4 [732.712135] Starting dynamic subtest: pipe-A-plane-0 [732.845320] Dynamic subtest pipe-A-plane-0: SUCCESS (0.133s) [732.856763] Starting dynamic subtest: pipe-A-plane-1 [732.958046] Dynamic subtest pipe-A-plane-1: SUCCESS (0.110s) [732.968352] Starting dynamic subtest: pipe-A-plane-2 [733.068243] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s) [734.281921] Starting dynamic subtest: pipe-B-plane-0 [734.418396] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [734.428827] Starting dynamic subtest: pipe-B-plane-1 [734.550734] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s) [734.561030] Starting dynamic subtest: pipe-B-plane-2 [734.673218] Dynamic subtest pipe-B-plane-2: SUCCESS (0.121s) [735.906545] Starting dynamic subtest: pipe-C-plane-0 [736.008683] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s) [736.019376] Starting dynamic subtest: pipe-C-plane-1 [736.120279] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s) [736.131115] Starting dynamic subtest: pipe-C-plane-2 [736.231106] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s) [737.427551] Starting dynamic subtest: pipe-D-plane-0 [737.529259] Dynamic subtest pipe-D-plane-0: SUCCESS (0.110s) [737.540105] Starting dynamic subtest: pipe-D-plane-1 [737.640191] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s) [737.650566] Starting dynamic subtest: pipe-D-plane-2 [737.762189] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s) [738.052444] Subtest plane-ctm3x4: SUCCESS (5.464s) [738.909182] [124/131] (283s left) kms_flip (2x-flip-vs-fences) [738.996798] Starting subtest: 2x-flip-vs-fences [739.000946] Subtest 2x-flip-vs-fences: SKIP (0.000s) [739.096581] [125/131] (283s left) gem_exec_schedule (u-submit-early-slice) [739.174514] Starting subtest: u-submit-early-slice [739.176741] Starting dynamic subtest: rcs0 [739.212125] Dynamic subtest rcs0: SUCCESS (0.044s) [739.226180] Starting dynamic subtest: bcs0 [739.252691] Dynamic subtest bcs0: SUCCESS (0.040s) [739.263857] Starting dynamic subtest: vcs0 [739.293112] Dynamic subtest vcs0: SUCCESS (0.040s) [739.304324] Starting dynamic subtest: vcs1 [739.329039] Dynamic subtest vcs1: SUCCESS (0.035s) [739.340040] Starting dynamic subtest: vecs0 [739.374625] Dynamic subtest vecs0: SUCCESS (0.044s) [739.385342] Starting dynamic subtest: ccs0 [739.419427] Dynamic subtest ccs0: SUCCESS (0.043s) [739.421728] Subtest u-submit-early-slice: SUCCESS (0.253s) [740.897113] [126/131] (281s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [740.997006] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [741.001308] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [741.082436] [127/131] (281s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [741.175955] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [741.180075] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [741.271251] [128/131] (281s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [741.378085] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [741.382487] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [741.486334] [129/131] (281s left) kms_psr (fbc-pr-sprite-plane-onoff) [741.577683] Starting subtest: fbc-pr-sprite-plane-onoff [741.581779] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [741.651430] [130/131] (281s left) kms_chamelium_edid (vga-edid-read) [742.051040] Subtest vga-edid-read: SKIP (0.000s) [742.821886] [131/131] (280s left) kms_busy (basic) [742.927558] Starting subtest: basic [742.929697] Starting dynamic subtest: flip [743.519147] Dynamic subtest flip: SUCCESS (0.593s) [743.530575] Starting dynamic subtest: modeset [747.207271] Dynamic subtest modeset: SUCCESS (3.685s) [747.209450] Subtest basic: SUCCESS (4.281s) [748.011740] Closing watchdogs results: parsing output: 0/ for test: kms_pipe_crc_basic results: parsing output: 1/ for test: api_intel_allocator results: parsing output: 2/ for test: gem_exec_balancer results: parsing output: 3/ for test: kms_atomic_transition results: parsing output: 4/ for test: gem_exec_whisper results: parsing output: 5/ for test: kms_plane results: parsing output: 6/ for test: kms_pm_rpm results: parsing output: 7/ for test: syncobj_wait results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: i915_module_load results: parsing output: 10/ for test: gem_exec_flush results: parsing output: 11/ for test: gem_softpin results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_setmode results: parsing output: 14/ for test: gem_exec_fence results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_pm_rpm results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: gem_softpin results: parsing output: 20/ for test: gem_userptr_blits results: parsing output: 21/ for test: gem_ccs results: parsing output: 22/ for test: gem_exec_params results: parsing output: 23/ for test: kms_dither results: parsing output: 24/ for test: gem_exec_reloc results: parsing output: 25/ for test: kms_plane results: parsing output: 26/ for test: prime_mmap results: parsing output: 27/ for test: gem_vm_create results: parsing output: 28/ for test: kms_atomic results: parsing output: 29/ for test: kms_cursor_crc results: parsing output: 30/ for test: syncobj_timeline results: parsing output: 31/ for test: kms_ccs results: parsing output: 32/ for test: gem_exec_schedule results: parsing output: 33/ for test: kms_chamelium_hpd results: parsing output: 34/ for test: gem_exec_params results: parsing output: 35/ for test: kms_cursor_crc results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: sysfs_timeslice_duration results: parsing output: 38/ for test: kms_ccs results: parsing output: 39/ for test: kms_content_protection results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: perf results: parsing output: 42/ for test: gem_exec_parallel results: parsing output: 43/ for test: kms_plane results: parsing output: 44/ for test: gem_render_copy results: parsing output: 45/ for test: gem_mmap_offset results: parsing output: 46/ for test: i915_suspend results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: gem_pxp results: parsing output: 49/ for test: kms_flip results: parsing output: 50/ for test: gem_workarounds results: parsing output: 51/ for test: gen9_exec_parse results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: syncobj_timeline results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: gem_ctx_persistence results: parsing output: 56/ for test: kms_flip results: parsing output: 57/ for test: core_sysfs results: parsing output: 58/ for test: gem_linear_blits results: parsing output: 59/ for test: kms_cursor_crc results: parsing output: 60/ for test: gem_softpin results: parsing output: 61/ for test: gem_exec_whisper results: parsing output: 62/ for test: kms_universal_plane results: parsing output: 63/ for test: syncobj_wait results: parsing output: 64/ for test: perf_pmu results: parsing output: 65/ for test: gem_exec_params results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: kms_chamelium_color results: parsing output: 68/ for test: gem_mmap_gtt results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: perf_pmu results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: kms_psr2_sf results: parsing output: 75/ for test: gem_pxp results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: kms_cursor_legacy results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_lease results: parsing output: 85/ for test: kms_tv_load_detect results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_plane_scaling results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: kms_flip results: parsing output: 91/ for test: gem_busy results: parsing output: 92/ for test: api_intel_bb results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_psr2_sf results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_userptr_blits results: parsing output: 98/ for test: syncobj_timeline results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: gem_ctx_param results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: i915_pm_rpm results: parsing output: 103/ for test: gem_exec_reloc results: parsing output: 104/ for test: gem_spin_batch results: parsing output: 105/ for test: kms_vblank results: parsing output: 106/ for test: kms_invalid_mode results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gen9_exec_parse results: parsing output: 109/ for test: kms_psr2_sf results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: gem_ctx_persistence results: parsing output: 112/ for test: gem_exec_params results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: kms_dsc results: parsing output: 116/ for test: kms_cursor_legacy results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_flip_scaled_crc results: parsing output: 119/ for test: perf_pmu results: parsing output: 120/ for test: syncobj_wait results: parsing output: 121/ for test: perf_pmu results: parsing output: 122/ for test: kms_color_pipeline results: parsing output: 123/ for test: kms_flip results: parsing output: 124/ for test: gem_exec_schedule results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_psr results: parsing output: 129/ for test: kms_chamelium_edid results: parsing output: 130/ for test: kms_busy Done.