[58.726176] Initializing watchdogs [58.726233] /dev/watchdog0 [58.739867] [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] [58.743634] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.745650] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.749088] [001/130] (960s left) kms_addfb_basic (master-rmfb) [58.876143] Starting subtest: master-rmfb [58.878498] Subtest master-rmfb: SUCCESS (0.001s) [59.023776] [002/130] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [59.135871] Starting subtest: psr-1p-primscrn-cur-indfb-move [64.185718] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (5.081s) [64.325031] [003/130] (954s left) gem_exec_whisper (basic-forked) [64.399690] Starting subtest: basic-forked [71.733529] Subtest basic-forked: SUCCESS (7.348s) [71.938211] [004/130] (947s left) i915_pm_rps (thresholds) [72.051921] Starting subtest: thresholds [72.057040] Subtest thresholds: SKIP (0.001s) [72.131223] [005/130] (947s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [72.224593] Starting subtest: invalid-multi-wait-unsubmitted-signaled [72.227122] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [72.432160] [006/130] (946s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc) [72.534880] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc [75.593530] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (3.066s) [75.732263] [007/130] (943s left) gem_exec_schedule (timeslicing) [75.818255] Starting subtest: timeslicing [75.820479] Starting dynamic subtest: rcs0 [75.834197] Dynamic subtest rcs0: SUCCESS (0.022s) [75.841081] Starting dynamic subtest: bcs0 [75.854428] Dynamic subtest bcs0: SUCCESS (0.020s) [75.860898] Starting dynamic subtest: vcs0 [75.877733] Dynamic subtest vcs0: SUCCESS (0.023s) [75.886259] Starting dynamic subtest: vcs1 [75.896260] Dynamic subtest vcs1: SUCCESS (0.019s) [75.902976] Starting dynamic subtest: vecs0 [75.915591] Dynamic subtest vecs0: SUCCESS (0.019s) [75.922500] Starting dynamic subtest: ccs0 [75.935065] Dynamic subtest ccs0: SUCCESS (0.019s) [75.937096] Subtest timeslicing: SUCCESS (0.123s) [77.961814] [008/130] (941s left) kms_big_fb (x-tiled-16bpp-rotate-0) [78.060176] Starting subtest: x-tiled-16bpp-rotate-0 [79.403762] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.345s) [79.646837] [009/130] (939s left) kms_plane_alpha_blend (alpha-opaque-fb) [79.741918] Starting subtest: alpha-opaque-fb [80.146634] Starting dynamic subtest: pipe-A-eDP-1 [80.711366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s) [80.720428] Starting dynamic subtest: pipe-D-eDP-1 [82.064386] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s) [82.066426] Subtest alpha-opaque-fb: SUCCESS (2.323s) [82.889262] [010/130] (936s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [82.990438] Starting subtest: fbcpsr-rgb565-draw-blt [87.882103] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (4.895s) [88.042287] [011/130] (931s left) perf (i915-ref-count) [88.107914] Starting subtest: i915-ref-count [88.169894] Subtest i915-ref-count: SUCCESS (0.060s) [88.220314] [012/130] (931s left) gem_partial_pwrite_pread (write-display) [88.276036] Subtest write-display: SKIP (0.000s) [88.348184] [013/130] (931s left) gem_mmap_wc (write-read-distinct) [88.405610] Subtest write-read-distinct: SKIP (0.000s) [88.477344] [014/130] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [88.580392] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [91.915732] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (3.339s) [92.045726] [015/130] (927s left) kms_lease (multimaster-lease) [92.136545] Starting subtest: multimaster-lease [92.141240] Subtest multimaster-lease: SUCCESS (0.003s) [92.244549] [016/130] (927s left) prime_self_import (export-vs-gem_close-race) [92.275487] Starting subtest: export-vs-gem_close-race [97.368331] Subtest export-vs-gem_close-race: SUCCESS (5.090s) [97.435411] [017/130] (922s left) kms_psr (fbc-psr2-dpms) [97.544907] Starting subtest: fbc-psr2-dpms [97.547526] Starting dynamic subtest: eDP-1 [97.552124] Dynamic subtest eDP-1: SKIP (0.000s) [97.556440] Subtest fbc-psr2-dpms: SKIP (0.000s) [97.614645] [018/130] (922s left) kms_feature_discovery (psr1) [97.713938] Starting subtest: psr1 [97.716254] Subtest psr1: SUCCESS (0.000s) [97.777739] [019/130] (922s left) kms_psr (pr-primary-page-flip) [97.879897] Starting subtest: pr-primary-page-flip [97.884588] Subtest pr-primary-page-flip: SKIP (0.000s) [97.944487] [020/130] (921s left) kms_flip (nonexisting-fb) [98.049294] Starting subtest: nonexisting-fb [98.051617] Starting dynamic subtest: A-eDP1 [99.268625] Dynamic subtest A-eDP1: SUCCESS (1.219s) [99.277448] Starting dynamic subtest: B-eDP1 [100.490234] Dynamic subtest B-eDP1: SUCCESS (1.221s) [100.497297] Starting dynamic subtest: C-eDP1 [101.624222] Dynamic subtest C-eDP1: SUCCESS (1.133s) [101.631925] Starting dynamic subtest: D-eDP1 [102.844863] Dynamic subtest D-eDP1: SUCCESS (1.220s) [102.850072] Subtest nonexisting-fb: SUCCESS (4.801s) [104.006808] [021/130] (915s left) kms_psr (fbc-pr-cursor-mmap-gtt) [104.107257] Starting subtest: fbc-pr-cursor-mmap-gtt [104.111676] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [104.171548] [022/130] (915s left) gen9_exec_parse (allowed-all) [104.238543] Subtest allowed-all: SKIP (0.000s) [104.323157] [023/130] (915s left) gem_eio (create-ext) [104.568479] Starting subtest: create-ext [104.929224] Subtest create-ext: SUCCESS (0.360s) [105.077856] [024/130] (914s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [105.168774] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [105.170875] Starting dynamic subtest: pipe-A-default-mode [105.469138] Dynamic subtest pipe-A-default-mode: SKIP (0.294s) [105.473868] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.295s) [106.247695] [025/130] (913s left) gem_userptr_blits (input-checking) [106.315966] Starting subtest: input-checking [106.318074] Subtest input-checking: SUCCESS (0.000s) [106.439412] [026/130] (913s left) gem_linear_blits (basic) [106.773868] Starting subtest: basic [106.779814] Subtest basic: SUCCESS (0.006s) [106.929069] [027/130] (913s left) kms_content_protection (content-type-change) [107.153672] Starting subtest: content-type-change [110.380890] Subtest content-type-change: SKIP (3.224s) [111.542219] [028/130] (908s left) kms_cursor_crc (cursor-random-128x128) [111.746719] Starting subtest: cursor-random-128x128 [111.751609] Starting dynamic subtest: pipe-A-eDP-1 [115.399415] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.648s) [115.436481] Starting dynamic subtest: pipe-D-eDP-1 [119.683232] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.253s) [119.685706] Subtest cursor-random-128x128: SUCCESS (7.936s) [120.491122] [029/130] (899s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [120.587440] Starting subtest: psr-farfromfence-mmap-gtt [120.591951] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [120.689899] [030/130] (899s left) dumb_buffer (invalid-bpp) [120.758983] Starting subtest: invalid-bpp [120.761188] Subtest invalid-bpp: SUCCESS (0.000s) [120.853513] [031/130] (899s left) kms_frontbuffer_tracking (fbc-suspend) [120.960520] Starting subtest: fbc-suspend [157.701764] Subtest fbc-suspend: SUCCESS (6.106s) [157.865488] [032/130] (893s left) gem_lmem_swapping (parallel-random-verify-ccs) [157.918541] Subtest parallel-random-verify-ccs: SKIP (0.000s) [157.953824] [033/130] (892s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [158.049750] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [158.052131] Starting dynamic subtest: pipe-A-eDP-1 [158.110331] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [158.119526] Starting dynamic subtest: pipe-B-eDP-1 [158.185717] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [158.194694] Starting dynamic subtest: pipe-C-eDP-1 [158.256654] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [158.264624] Starting dynamic subtest: pipe-D-eDP-1 [158.329122] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [158.333701] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s) [160.171734] [034/130] (890s left) gem_mmap_offset (bad-object) [160.237961] Starting subtest: bad-object [160.240697] Subtest bad-object: SUCCESS (0.001s) [160.337009] [035/130] (890s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [160.403786] Starting subtest: yf-tiled-to-vebox-y-tiled [160.409270] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [160.584696] [036/130] (890s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [160.700836] Starting subtest: yf-tiled-8bpp-rotate-90 [160.705792] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [160.788238] [037/130] (890s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [160.892729] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [160.897761] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [160.995965] [038/130] (890s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [161.093020] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [161.095903] Starting dynamic subtest: pipe-A-eDP-1 [161.120224] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [161.128848] Starting dynamic subtest: pipe-B-eDP-1 [161.153672] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [161.162109] Starting dynamic subtest: pipe-C-eDP-1 [161.186959] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [161.194810] Starting dynamic subtest: pipe-D-eDP-1 [161.219971] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [161.225210] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.004s) [163.196315] [039/130] (887s left) gem_pxp (create-protected-buffer) [163.325301] Starting subtest: create-protected-buffer [163.328172] Subtest create-protected-buffer: SUCCESS (0.000s) [163.424817] [040/130] (887s left) perf_pmu (render-node-busy-idle) [163.490184] Starting subtest: render-node-busy-idle [163.492786] Starting dynamic subtest: rcs0 [164.210364] Dynamic subtest rcs0: SUCCESS (0.726s) [164.222152] Starting dynamic subtest: bcs0 [164.874249] Dynamic subtest bcs0: SUCCESS (0.668s) [164.884985] Starting dynamic subtest: vcs0 [166.617884] Dynamic subtest vcs0: SUCCESS (1.752s) [166.628369] Starting dynamic subtest: vcs1 [168.601533] Dynamic subtest vcs1: SUCCESS (1.993s) [168.613510] Starting dynamic subtest: vecs0 [170.649813] Dynamic subtest vecs0: SUCCESS (2.055s) [170.661825] Starting dynamic subtest: ccs0 [171.311026] Dynamic subtest ccs0: SUCCESS (0.664s) [171.313892] Subtest render-node-busy-idle: SUCCESS (7.865s) [171.380193] [041/130] (879s left) kms_psr2_su (frontbuffer-xrgb8888) [171.439026] Subtest frontbuffer-XRGB8888: SKIP (0.000s) [171.505377] [042/130] (879s left) kms_flip (2x-absolute-wf_vblank-interruptible) [171.608747] Starting subtest: 2x-absolute-wf_vblank-interruptible [171.620143] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s) [171.702563] [043/130] (879s left) sriov_basic (enable-vfs-autoprobe-on) [171.769281] Starting subtest: enable-vfs-autoprobe-on [171.771858] Starting dynamic subtest: numvfs-1 [171.859504] Dynamic subtest numvfs-1: FAIL (0.027s) [171.868810] Starting dynamic subtest: numvfs-2 [171.957699] Dynamic subtest numvfs-2: FAIL (0.004s) [171.967274] Starting dynamic subtest: numvfs-3 [172.053386] Dynamic subtest numvfs-3: FAIL (0.003s) [172.062737] Starting dynamic subtest: numvfs-4 [172.147978] Dynamic subtest numvfs-4: FAIL (0.003s) [172.157498] Starting dynamic subtest: numvfs-5 [172.233819] Dynamic subtest numvfs-5: FAIL (0.003s) [172.241671] Starting dynamic subtest: numvfs-6 [172.311605] Dynamic subtest numvfs-6: FAIL (0.003s) [172.318985] Starting dynamic subtest: numvfs-7 [172.384175] Dynamic subtest numvfs-7: FAIL (0.003s) [172.393644] Starting dynamic subtest: numvfs-random [172.463995] Dynamic subtest numvfs-random: FAIL (0.003s) [172.473805] Starting dynamic subtest: numvfs-all [172.537209] Dynamic subtest numvfs-all: FAIL (0.544s) [172.538848] Subtest enable-vfs-autoprobe-on: FAIL (0.597s) [172.566256] [044/130] (878s left) gem_ctx_exec (basic-nohangcheck) [172.617007] Starting subtest: basic-nohangcheck [172.876985] Subtest basic-nohangcheck: SUCCESS (0.262s) [173.009736] [045/130] (878s left) gem_mmap_gtt (cpuset-medium-copy) [173.062219] Subtest cpuset-medium-copy: SKIP (0.000s) [173.118836] [046/130] (878s left) gem_ringfill (basic-all) [178.653321] Starting subtest: basic-all [179.837826] Subtest basic-all: SUCCESS (1.186s) [179.976993] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true [179.980573] [047/130] (871s left) prime_mmap (test_dup) [180.047720] Starting subtest: test_dup [180.049970] Starting dynamic subtest: test_dup-smem [180.078955] Dynamic subtest test_dup-smem: SUCCESS (0.033s) [180.081888] Subtest test_dup: SUCCESS (0.033s) [180.152891] [048/130] (871s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [180.269520] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [180.274762] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [180.385564] [049/130] (870s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [180.517042] Starting subtest: basic-flip-before-cursor-atomic [181.437271] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.919s) [182.251731] [050/130] (869s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf) [187.321696] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf [187.327576] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.003s) [188.166549] [051/130] (863s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation) [188.270501] Starting subtest: plane-downscale-factor-0-25-with-rotation [188.273013] Starting dynamic subtest: pipe-A [188.287113] Dynamic subtest pipe-A: SKIP (0.011s) [188.296739] Starting dynamic subtest: pipe-B [188.307318] Dynamic subtest pipe-B: SKIP (0.020s) [188.316507] Starting dynamic subtest: pipe-C [188.326721] Dynamic subtest pipe-C: SKIP (0.020s) [188.335506] Starting dynamic subtest: pipe-D [188.349841] Dynamic subtest pipe-D: SKIP (0.020s) [188.354894] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (0.071s) [188.444270] [052/130] (863s left) kms_color (deep-color) [188.531508] Starting subtest: deep-color [189.638860] Starting dynamic subtest: pipe-A-eDP-1-gamma [190.354968] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.714s) [190.364930] Starting dynamic subtest: pipe-A-eDP-1-degamma [191.817844] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.460s) [191.829760] Starting dynamic subtest: pipe-A-eDP-1-ctm [193.224171] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.403s) [194.037013] Starting dynamic subtest: pipe-B-eDP-1-gamma [194.711165] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.680s) [194.721566] Starting dynamic subtest: pipe-B-eDP-1-degamma [196.113337] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.400s) [196.123986] Starting dynamic subtest: pipe-B-eDP-1-ctm [197.517964] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.402s) [198.313793] Starting dynamic subtest: pipe-C-eDP-1-gamma [198.989147] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.680s) [198.999600] Starting dynamic subtest: pipe-C-eDP-1-degamma [200.341043] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.350s) [200.351968] Starting dynamic subtest: pipe-C-eDP-1-ctm [201.705504] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.366s) [202.506015] Starting dynamic subtest: pipe-D-eDP-1-gamma [203.188961] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.690s) [203.200292] Starting dynamic subtest: pipe-D-eDP-1-degamma [204.528597] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.338s) [204.544811] Starting dynamic subtest: pipe-D-eDP-1-ctm [205.940299] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.411s) [205.943137] Subtest deep-color: SUCCESS (17.395s) [206.727495] [053/130] (844s left) kms_big_fb (4-tiled-16bpp-rotate-180) [206.841960] Starting subtest: 4-tiled-16bpp-rotate-180 [208.243810] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.401s) [208.381426] [054/130] (843s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [208.501267] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [208.505628] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [208.596962] [055/130] (842s left) i915_hangman (engine-engine-error) [208.667663] Starting subtest: engine-engine-error [208.670137] Starting dynamic subtest: rcs0 [210.616310] Dynamic subtest rcs0: SUCCESS (1.947s) [210.629471] Starting dynamic subtest: bcs0 [212.600181] Dynamic subtest bcs0: SUCCESS (1.981s) [212.612510] Starting dynamic subtest: vcs0 [214.584013] Dynamic subtest vcs0: SUCCESS (1.981s) [214.596026] Starting dynamic subtest: vcs1 [216.568787] Dynamic subtest vcs1: SUCCESS (1.983s) [216.580978] Starting dynamic subtest: vecs0 [218.615986] Dynamic subtest vecs0: SUCCESS (2.045s) [218.628155] Starting dynamic subtest: ccs0 [220.598989] Dynamic subtest ccs0: SUCCESS (1.981s) [220.601984] Subtest engine-engine-error: SUCCESS (11.932s) [220.678299] [056/130] (830s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [220.776958] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [220.779998] Starting dynamic subtest: pipe-A-default-mode [221.083140] Dynamic subtest pipe-A-default-mode: SKIP (0.300s) [221.088957] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.302s) [221.860404] [057/130] (829s left) gem_exec_parallel (userptr) [221.926487] Starting subtest: userptr [221.929015] Starting dynamic subtest: rcs0 [223.573817] Dynamic subtest rcs0: SUCCESS (1.647s) [223.582868] Starting dynamic subtest: bcs0 [225.256393] Dynamic subtest bcs0: SUCCESS (1.680s) [225.268962] Starting dynamic subtest: vcs0 [228.569816] Dynamic subtest vcs0: SUCCESS (3.311s) [228.581489] Starting dynamic subtest: vcs1 [230.619495] Dynamic subtest vcs1: SUCCESS (2.047s) [230.631785] Starting dynamic subtest: vecs0 [232.601666] Dynamic subtest vecs0: SUCCESS (1.980s) [232.614199] Starting dynamic subtest: ccs0 [234.387170] Dynamic subtest ccs0: SUCCESS (1.786s) [234.390000] Subtest userptr: SUCCESS (12.463s) [234.570835] [058/130] (817s left) gem_close (many-handles-one-vma) [234.621033] Starting subtest: many-handles-one-vma [234.652518] Subtest many-handles-one-vma: SUCCESS (0.034s) [234.787691] [059/130] (816s left) gem_softpin (zero) [234.851972] Starting subtest: zero [234.860629] Subtest zero: SUCCESS (0.009s) [235.006604] [060/130] (816s left) kms_cursor_edge_walk (128x128-left-edge) [235.112417] Starting subtest: 128x128-left-edge [235.114889] Starting dynamic subtest: pipe-A-eDP-1 [238.509322] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.396s) [238.518580] Starting dynamic subtest: pipe-D-eDP-1 [241.625898] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s) [241.628340] Subtest 128x128-left-edge: SUCCESS (6.512s) [242.441989] [061/130] (809s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite) [242.562559] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite [248.730040] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (6.173s) [248.849959] [062/130] (802s left) kms_chamelium_color (ctm-limited-range) [248.951825] Subtest ctm-limited-range: SKIP (0.000s) [248.992594] [063/130] (802s left) kms_cursor_edge_walk (256x256-left-edge) [249.102887] Starting subtest: 256x256-left-edge [249.105695] Starting dynamic subtest: pipe-A-eDP-1 [252.513843] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.412s) [252.522731] Starting dynamic subtest: pipe-D-eDP-1 [255.642653] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s) [255.645229] Subtest 256x256-left-edge: SUCCESS (6.540s) [256.437374] [064/130] (795s left) gem_fence_thrash (bo-write-verify-none) [256.476141] Starting subtest: bo-write-verify-none [256.496798] Subtest bo-write-verify-none: SKIP (0.020s) [256.553367] [065/130] (795s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu) [256.653849] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu [261.218482] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.568s) [261.327080] [066/130] (790s left) gem_tiled_fence_blits (basic) [261.399212] Subtest basic: SKIP (0.000s) [261.476142] [067/130] (790s left) kms_psr (psr-primary-render) [261.571912] Starting subtest: psr-primary-render [261.574757] Starting dynamic subtest: eDP-1 [263.311866] Dynamic subtest eDP-1: SUCCESS (1.738s) [263.314028] Subtest psr-primary-render: SUCCESS (1.739s) [264.150418] [068/130] (787s left) kms_dsc (dsc-with-output-formats) [264.255586] Starting subtest: dsc-with-output-formats [264.281551] Subtest dsc-with-output-formats: SKIP (0.000s) [264.325590] [069/130] (787s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [264.395482] Starting subtest: single-wait-all-for-submit-available-submitted [264.398144] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [264.490825] [070/130] (787s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [264.601103] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [264.605831] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [264.706381] [071/130] (787s left) syncobj_wait (reset-during-wait-for-submit) [264.769138] Starting subtest: reset-during-wait-for-submit [264.871830] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [264.947320] [072/130] (787s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [265.061791] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [265.066697] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [265.159701] [073/130] (787s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [265.268007] Starting subtest: psr-rgb565-draw-render [270.173621] Subtest psr-rgb565-draw-render: SUCCESS (4.907s) [270.279486] [074/130] (781s left) kms_psr (psr-suspend) [270.389948] Starting subtest: psr-suspend [270.392988] Starting dynamic subtest: eDP-1 [288.003636] Dynamic subtest eDP-1: SUCCESS (2.900s) [288.006149] Subtest psr-suspend: SUCCESS (2.901s) [288.839383] [075/130] (778s left) kms_cdclk (mode-transition) [288.938692] Starting subtest: mode-transition [288.941129] Starting dynamic subtest: pipe-A-eDP-1 [289.222451] Dynamic subtest pipe-A-eDP-1: SKIP (0.285s) [289.232148] Starting dynamic subtest: pipe-B-eDP-1 [289.237478] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [289.246414] Starting dynamic subtest: pipe-C-eDP-1 [289.250920] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [289.259664] Starting dynamic subtest: pipe-D-eDP-1 [289.264776] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [289.269802] Subtest mode-transition: SKIP (0.292s) [290.041224] [076/130] (776s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [290.150582] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [290.154885] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [290.254844] [077/130] (776s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [290.625877] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [291.419829] [078/130] (775s left) api_intel_allocator (standalone) [291.481460] Starting subtest: standalone [291.503269] Subtest standalone: SUCCESS (0.025s) [291.638573] [079/130] (775s left) gem_exec_params (invalid-bsd1-flag-on-blt) [291.693226] Starting subtest: invalid-bsd1-flag-on-blt [291.695794] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [291.791717] [080/130] (775s left) gem_exec_balancer (smoke) [291.849846] Starting subtest: smoke [314.163840] Subtest smoke: SUCCESS (22.422s) [315.238408] [081/130] (751s left) kms_pm_rpm (dpms-mode-unset-lpsp) [317.498743] Starting subtest: dpms-mode-unset-lpsp [321.552496] Subtest dpms-mode-unset-lpsp: SUCCESS (4.056s) [321.913153] [082/130] (745s left) kms_flip (wf_vblank-ts-check) [322.017912] Starting subtest: wf_vblank-ts-check [322.020577] Starting dynamic subtest: A-eDP1 [330.952147] Dynamic subtest A-eDP1: SUCCESS (8.931s) [330.963907] Starting dynamic subtest: B-eDP1 [339.874481] Dynamic subtest B-eDP1: SUCCESS (8.921s) [339.885661] Starting dynamic subtest: C-eDP1 [348.787708] Dynamic subtest C-eDP1: SUCCESS (8.912s) [348.800079] Starting dynamic subtest: D-eDP1 [357.712707] Dynamic subtest D-eDP1: SUCCESS (8.926s) [357.715721] Subtest wf_vblank-ts-check: SUCCESS (35.698s) [358.923547] [083/130] (708s left) gem_userptr_blits (unsync-unmap) [358.992912] Subtest unsync-unmap: SKIP (0.000s) [359.126553] [084/130] (708s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [359.231863] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [359.237136] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [359.356527] [085/130] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [359.456897] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [359.461973] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [359.565522] [086/130] (707s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [359.673935] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [359.679033] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [359.777358] [087/130] (707s left) i915_pm_rpm (debugfs-forcewake-user) [361.513857] Starting subtest: debugfs-forcewake-user [372.907327] Subtest debugfs-forcewake-user: SUCCESS (11.397s) [373.270225] [088/130] (694s left) kms_getfb (getfb-handle-not-fb) [373.329752] Starting subtest: getfb-handle-not-fb [373.368103] Subtest getfb-handle-not-fb: SUCCESS (0.041s) [373.469203] [089/130] (693s left) sw_sync (timeline_closed_signaled) [373.510098] Starting subtest: timeline_closed_signaled [373.512862] Subtest timeline_closed_signaled: SUCCESS (0.000s) [373.553279] [090/130] (693s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [373.650635] Starting subtest: primary-yf-tiled-reflect-x-270 [373.655342] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [373.720361] [091/130] (693s left) kms_big_fb (linear-32bpp-rotate-180) [373.830618] Starting subtest: linear-32bpp-rotate-180 [375.673785] Subtest linear-32bpp-rotate-180: SUCCESS (1.844s) [375.950119] [092/130] (691s left) gem_ctx_param (invalid-get-no-zeromap) [376.011673] Starting subtest: invalid-get-no-zeromap [376.015122] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [376.124513] [093/130] (691s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [376.230062] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [376.232700] Starting dynamic subtest: pipe-A [376.245133] Dynamic subtest pipe-A: SKIP (0.007s) [376.254097] Starting dynamic subtest: pipe-B [376.263533] Dynamic subtest pipe-B: SKIP (0.015s) [376.273522] Starting dynamic subtest: pipe-C [376.284098] Dynamic subtest pipe-C: SKIP (0.016s) [376.298985] Starting dynamic subtest: pipe-D [376.308137] Dynamic subtest pipe-D: SKIP (0.016s) [376.312900] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.056s) [376.380364] [094/130] (691s left) kms_busy (extended-modeset-hang-oldfb) [376.488107] Starting subtest: extended-modeset-hang-oldfb [376.490618] Starting dynamic subtest: pipe-A [388.425978] Dynamic subtest pipe-A: SUCCESS (11.935s) [388.438868] Starting dynamic subtest: pipe-D [400.696446] Dynamic subtest pipe-D: SUCCESS (12.263s) [400.699184] Subtest extended-modeset-hang-oldfb: SUCCESS (24.202s) [401.476173] [095/130] (666s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [401.594745] Starting subtest: flip-vs-cursor-atomic-transitions [408.920962] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.322s) [409.707284] [096/130] (657s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [409.762015] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [409.764430] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [409.839640] [097/130] (657s left) gem_exec_balancer (parallel-bb-first) [410.079531] Starting subtest: parallel-bb-first [410.852508] Subtest parallel-bb-first: SUCCESS (0.772s) [411.389397] [098/130] (656s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [411.455337] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [411.560360] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s) [411.630930] [099/130] (656s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels) [411.724891] Starting subtest: plane-all-modeset-transition-fencing-internal-panels [411.727751] Starting dynamic subtest: pipe-A-eDP-1 [413.051984] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.324s) [413.332147] Starting dynamic subtest: pipe-B-eDP-1 [414.371058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s) [414.635418] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.909s) [415.476412] [100/130] (652s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [415.587682] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [415.593439] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [415.666678] [101/130] (652s left) dmabuf_sync_file (export-wait-after-attach) [415.712845] Starting subtest: export-wait-after-attach [415.715505] Subtest export-wait-after-attach: SUCCESS (0.000s) [415.763251] [102/130] (652s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [415.857874] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [415.860525] Starting dynamic subtest: pipe-A [415.879558] Dynamic subtest pipe-A: SKIP (0.014s) [415.891538] Starting dynamic subtest: pipe-B [415.906569] Dynamic subtest pipe-B: SKIP (0.026s) [415.917997] Starting dynamic subtest: pipe-C [415.932913] Dynamic subtest pipe-C: SKIP (0.024s) [415.942136] Starting dynamic subtest: pipe-D [415.956512] Dynamic subtest pipe-D: SKIP (0.025s) [415.961026] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.093s) [416.056032] [103/130] (651s left) kms_vblank (wait-forked) [416.154823] Starting subtest: wait-forked [416.157418] Starting dynamic subtest: pipe-A-eDP-1 [417.988168] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.830s) [418.005714] Starting dynamic subtest: pipe-D-eDP-1 [420.470377] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.479s) [420.472962] Subtest wait-forked: SUCCESS (4.313s) [421.318916] [104/130] (646s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [421.415922] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [421.418780] Starting dynamic subtest: pipe-A-eDP-1 [421.444842] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [421.454892] Starting dynamic subtest: pipe-B-eDP-1 [421.480062] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [421.488946] Starting dynamic subtest: pipe-C-eDP-1 [421.513141] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [421.521595] Starting dynamic subtest: pipe-D-eDP-1 [421.544722] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [421.548910] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [423.558550] [105/130] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [423.668829] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [427.982145] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.318s) [428.100971] [106/130] (639s left) gem_exec_reloc (basic-gtt-wc-active) [428.177586] Subtest basic-gtt-wc-active: SKIP (0.000s) [428.252940] [107/130] (639s left) kms_getfb (getfb-handle-zero) [428.313143] Starting subtest: getfb-handle-zero [428.316125] Subtest getfb-handle-zero: SUCCESS (0.000s) [428.420902] [108/130] (639s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [428.536076] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [433.398271] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.866s) [433.504820] [109/130] (634s left) vgem_basic (bad-fence) [433.551742] Starting subtest: bad-fence [433.553925] Subtest bad-fence: SUCCESS (0.000s) [433.602342] [110/130] (634s left) gem_ctx_persistence (legacy-engines-mixed-process) [433.662255] Starting subtest: legacy-engines-mixed-process [433.664964] Starting dynamic subtest: render [435.370744] Dynamic subtest render: SUCCESS (1.708s) [435.381838] Starting dynamic subtest: bsd1 [437.337810] Dynamic subtest bsd1: SUCCESS (1.965s) [437.347748] Starting dynamic subtest: bsd2 [439.407779] Dynamic subtest bsd2: SUCCESS (2.069s) [439.419962] Starting dynamic subtest: blt [441.398857] Dynamic subtest blt: SUCCESS (1.989s) [441.411154] Starting dynamic subtest: vebox [443.349829] Dynamic subtest vebox: SUCCESS (1.949s) [443.352974] Subtest legacy-engines-mixed-process: SUCCESS (9.688s) [443.425444] [111/130] (624s left) perf (gen12-mi-rpc) [443.522610] Starting subtest: gen12-mi-rpc [443.525291] Starting dynamic subtest: rcs0 [443.550516] Dynamic subtest rcs0: SUCCESS (0.026s) [443.552950] Subtest gen12-mi-rpc: SUCCESS (0.027s) [443.595840] [112/130] (624s left) kms_invalid_mode (uint-max-clock) [443.702968] Starting subtest: uint-max-clock [443.705774] Starting dynamic subtest: pipe-A-eDP-1 [443.985906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s) [443.995780] Starting dynamic subtest: pipe-B-eDP-1 [443.998417] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [444.007992] Starting dynamic subtest: pipe-C-eDP-1 [444.010656] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [444.021000] Starting dynamic subtest: pipe-D-eDP-1 [444.024036] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [444.026953] Subtest uint-max-clock: SUCCESS (0.286s) [444.793354] [113/130] (623s left) i915_suspend (forcewake) [444.860935] Starting subtest: forcewake [477.509858] Subtest forcewake: SUCCESS (2.164s) [477.588073] [114/130] (621s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [477.719450] Starting subtest: nonblocking-modeset-vs-cursor-atomic [479.068124] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.370s) [479.850786] [115/130] (618s left) gem_exec_fence (syncobj-repeat) [480.319502] Starting subtest: syncobj-repeat [480.490625] Subtest syncobj-repeat: SUCCESS (0.172s) [481.924188] [116/130] (616s left) kms_psr (fbc-psr-sprite-blt) [482.019391] Starting subtest: fbc-psr-sprite-blt [482.021681] Starting dynamic subtest: eDP-1 [482.025707] Dynamic subtest eDP-1: SKIP (0.000s) [482.029717] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [482.086652] [117/130] (616s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [482.179233] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [482.181496] Starting dynamic subtest: pipe-A-eDP-1 [482.204005] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [482.213297] Starting dynamic subtest: pipe-B-eDP-1 [482.234384] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [482.242818] Starting dynamic subtest: pipe-C-eDP-1 [482.264956] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [482.275574] Starting dynamic subtest: pipe-D-eDP-1 [482.296951] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [482.301419] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [484.345514] [118/130] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [484.451261] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [484.455340] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [484.554682] [119/130] (614s left) syncobj_wait (wait-all-complex) [484.617311] Starting subtest: wait-all-complex [484.831099] Subtest wait-all-complex: SUCCESS (0.214s) [484.899314] [120/130] (613s left) gem_ppgtt (blt-vs-render-ctx0) [484.949830] Starting subtest: blt-vs-render-ctx0 [517.817831] Subtest blt-vs-render-ctx0: SUCCESS (32.932s) [517.945431] [121/130] (580s left) syncobj_timeline (multi-wait-available-signaled) [518.046280] Starting subtest: multi-wait-available-signaled [518.048809] Subtest multi-wait-available-signaled: SUCCESS (0.000s) [518.141966] [122/130] (580s left) api_intel_bb (reset-bb) [518.198891] Starting subtest: reset-bb [518.203516] Subtest reset-bb: SUCCESS (0.006s) [518.342949] [123/130] (580s left) gem_close_race (multigpu-basic-threads) [518.416450] Starting subtest: multigpu-basic-threads [518.421112] Subtest multigpu-basic-threads: SKIP (0.000s) [518.668699] [124/130] (580s left) kms_big_fb (x-tiled-8bpp-rotate-180) [518.782354] Starting subtest: x-tiled-8bpp-rotate-180 [519.906426] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.125s) [520.050581] [125/130] (578s left) gem_exec_fence (basic-busy-all) [520.117630] Starting subtest: basic-busy-all [520.223229] Subtest basic-busy-all: SUCCESS (0.106s) [521.903558] [126/130] (577s left) kms_vblank (query-forked-busy) [522.001281] Starting subtest: query-forked-busy [522.003727] Starting dynamic subtest: pipe-A-eDP-1 [523.878899] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s) [523.894787] Starting dynamic subtest: pipe-D-eDP-1 [526.441460] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s) [526.443799] Subtest query-forked-busy: SUCCESS (4.438s) [527.232692] [127/130] (571s left) gem_exec_schedule (preempt-hang) [527.412419] Starting subtest: preempt-hang [527.415047] Starting dynamic subtest: rcs0 [527.645047] Dynamic subtest rcs0: SUCCESS (0.232s) [527.656813] Starting dynamic subtest: bcs0 [527.870036] Dynamic subtest bcs0: SUCCESS (0.223s) [527.879603] Starting dynamic subtest: vcs0 [528.099281] Dynamic subtest vcs0: SUCCESS (0.229s) [528.110441] Starting dynamic subtest: vcs1 [528.320744] Dynamic subtest vcs1: SUCCESS (0.221s) [528.330841] Starting dynamic subtest: vecs0 [528.550731] Dynamic subtest vecs0: SUCCESS (0.228s) [528.561162] Starting dynamic subtest: ccs0 [528.772380] Dynamic subtest ccs0: SUCCESS (0.221s) [528.774324] Subtest preempt-hang: SUCCESS (1.360s) [529.946202] [128/130] (569s left) syncobj_timeline (single-wait-signaled) [530.000247] Starting subtest: single-wait-signaled [530.002663] Subtest single-wait-signaled: SUCCESS (0.000s) [530.105969] [129/130] (569s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [530.208458] Starting subtest: fbc-modesetfrombusy [532.857199] Subtest fbc-modesetfrombusy: SUCCESS (2.653s) [533.000425] [130/130] (566s left) kms_setmode (basic) [533.059088] Starting subtest: basic [533.389738] Starting dynamic subtest: pipe-A-eDP-1 [535.497644] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.103s) [535.852503] Starting dynamic subtest: pipe-B-eDP-1 [537.926252] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.080s) [538.234692] Subtest basic: SUCCESS (5.171s) [539.055047] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: gem_exec_whisper results: parsing output: 3/ for test: i915_pm_rps results: parsing output: 4/ for test: syncobj_timeline results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_exec_schedule results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: kms_plane_alpha_blend results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: perf results: parsing output: 11/ for test: gem_partial_pwrite_pread results: parsing output: 12/ for test: gem_mmap_wc results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_lease results: parsing output: 15/ for test: prime_self_import results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: kms_feature_discovery results: parsing output: 18/ for test: kms_psr results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: gen9_exec_parse results: parsing output: 22/ for test: gem_eio results: parsing output: 23/ for test: kms_flip_scaled_crc results: parsing output: 24/ for test: gem_userptr_blits results: parsing output: 25/ for test: gem_linear_blits results: parsing output: 26/ for test: kms_content_protection results: parsing output: 27/ for test: kms_cursor_crc results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: dumb_buffer results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_lmem_swapping results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: gem_mmap_offset results: parsing output: 34/ for test: gem_render_copy results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_ccs results: parsing output: 38/ for test: gem_pxp results: parsing output: 39/ for test: perf_pmu results: parsing output: 40/ for test: kms_psr2_su results: parsing output: 41/ for test: kms_flip results: parsing output: 42/ for test: sriov_basic results: parsing output: 43/ for test: gem_ctx_exec results: parsing output: 44/ for test: gem_mmap_gtt results: parsing output: 45/ for test: gem_ringfill results: parsing output: 46/ for test: prime_mmap results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_cursor_legacy results: parsing output: 49/ for test: kms_psr2_sf results: parsing output: 50/ for test: kms_plane_scaling results: parsing output: 51/ for test: kms_color results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_legacy results: parsing output: 54/ for test: i915_hangman results: parsing output: 55/ for test: kms_flip_scaled_crc results: parsing output: 56/ for test: gem_exec_parallel results: parsing output: 57/ for test: gem_close results: parsing output: 58/ for test: gem_softpin results: parsing output: 59/ for test: kms_cursor_edge_walk results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_chamelium_color results: parsing output: 62/ for test: kms_cursor_edge_walk results: parsing output: 63/ for test: gem_fence_thrash results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_tiled_fence_blits results: parsing output: 66/ for test: kms_psr results: parsing output: 67/ for test: kms_dsc results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: syncobj_wait results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: kms_cdclk results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_chamelium_hpd results: parsing output: 77/ for test: api_intel_allocator results: parsing output: 78/ for test: gem_exec_params results: parsing output: 79/ for test: gem_exec_balancer results: parsing output: 80/ for test: kms_pm_rpm results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: gem_userptr_blits results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: i915_pm_rpm results: parsing output: 87/ for test: kms_getfb results: parsing output: 88/ for test: sw_sync results: parsing output: 89/ for test: kms_rotation_crc results: parsing output: 90/ for test: kms_big_fb results: parsing output: 91/ for test: gem_ctx_param results: parsing output: 92/ for test: kms_plane_scaling results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: gem_exec_balancer results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: kms_atomic_transition results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: dmabuf_sync_file results: parsing output: 101/ for test: kms_plane_scaling results: parsing output: 102/ for test: kms_vblank results: parsing output: 103/ for test: kms_ccs results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: kms_getfb results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: vgem_basic results: parsing output: 109/ for test: gem_ctx_persistence results: parsing output: 110/ for test: perf results: parsing output: 111/ for test: kms_invalid_mode results: parsing output: 112/ for test: i915_suspend results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: gem_exec_fence results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_ccs results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: syncobj_wait results: parsing output: 119/ for test: gem_ppgtt results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: api_intel_bb results: parsing output: 122/ for test: gem_close_race results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: gem_exec_fence results: parsing output: 125/ for test: kms_vblank results: parsing output: 126/ for test: gem_exec_schedule results: parsing output: 127/ for test: syncobj_timeline results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_setmode Done.