[56.679030] Initializing watchdogs [56.679127] /dev/watchdog0 [56.692636] [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] [56.696400] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.698462] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.701633] [001/130] (960s left) api_intel_allocator (reloc-allocator) [56.813516] Starting subtest: reloc-allocator [56.815680] Starting dynamic subtest: basic [56.818187] Dynamic subtest basic: SUCCESS (0.005s) [56.824406] Starting dynamic subtest: parallel-one [56.826693] Dynamic subtest parallel-one: SUCCESS (0.008s) [56.832885] Starting dynamic subtest: print [56.835176] Dynamic subtest print: SUCCESS (0.000s) [56.844177] Starting dynamic subtest: reuse [56.846130] Dynamic subtest reuse: SUCCESS (0.000s) [56.851622] Starting dynamic subtest: fork-reopen-allocator [56.853522] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s) [56.855406] Subtest reloc-allocator: SUCCESS (0.025s) [56.961978] [002/130] (960s left) kms_flip_event_leak (basic) [57.067853] Starting subtest: basic [57.070102] Starting dynamic subtest: pipe-A-eDP-1 [57.544205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.475s) [57.551540] Starting dynamic subtest: pipe-B-eDP-1 [58.701287] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s) [58.708777] Starting dynamic subtest: pipe-C-eDP-1 [59.811195] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s) [59.818911] Starting dynamic subtest: pipe-D-eDP-1 [60.930657] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s) [60.933167] Subtest basic: SUCCESS (3.862s) [61.781042] [003/130] (955s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [61.893148] Starting subtest: psr-rgb565-draw-render [66.721648] Subtest psr-rgb565-draw-render: SUCCESS (4.832s) [66.835688] [004/130] (950s left) kms_vblank (ts-continuation-modeset-hang) [66.932123] Starting subtest: ts-continuation-modeset-hang [66.934520] Starting dynamic subtest: pipe-A-eDP-1 [93.666763] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.732s) [93.679283] Starting dynamic subtest: pipe-D-eDP-1 [108.719545] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.050s) [108.721494] Subtest ts-continuation-modeset-hang: SUCCESS (41.786s) [109.522220] [005/130] (907s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [109.624909] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [109.627315] Starting dynamic subtest: pipe-A-eDP-1 [109.827526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.191s) [109.834617] Starting dynamic subtest: pipe-B-eDP-1 [109.860382] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s) [109.869701] Starting dynamic subtest: pipe-C-eDP-1 [109.888677] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s) [109.894886] Starting dynamic subtest: pipe-D-eDP-1 [109.914155] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s) [109.916350] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.220s) [112.079612] [006/130] (905s left) kms_addfb_basic (bad-pitch-65536) [112.139549] Starting subtest: bad-pitch-65536 [112.142017] Subtest bad-pitch-65536: SUCCESS (0.000s) [112.261262] [007/130] (905s left) kms_big_fb (4-tiled-addfb) [112.366951] Starting subtest: 4-tiled-addfb [112.368904] Subtest 4-tiled-addfb: SUCCESS (0.000s) [112.467112] [008/130] (904s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [112.568030] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [112.570521] Starting dynamic subtest: pipe-A-default-mode [112.854737] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [112.859416] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.284s) [113.694267] [009/130] (903s left) gem_exec_reloc (basic-wc-noreloc) [113.755761] Subtest basic-wc-noreloc: SKIP (0.000s) [113.822622] [010/130] (903s left) drm_fdinfo (virtual-busy-all) [113.863186] Starting subtest: virtual-busy-all [113.867871] Subtest virtual-busy-all: SKIP (0.000s) [113.914656] [011/130] (903s left) perf_pmu (busy-hang) [113.956204] Starting subtest: busy-hang [113.958663] Starting dynamic subtest: rcs0 [115.197299] Dynamic subtest rcs0: SUCCESS (1.239s) [115.206586] Starting dynamic subtest: bcs0 [116.399486] Dynamic subtest bcs0: SUCCESS (1.202s) [116.409096] Starting dynamic subtest: vcs0 [118.442534] Dynamic subtest vcs0: SUCCESS (2.043s) [118.451666] Starting dynamic subtest: vcs1 [120.433353] Dynamic subtest vcs1: SUCCESS (1.991s) [120.443059] Starting dynamic subtest: vecs0 [122.484373] Dynamic subtest vecs0: SUCCESS (2.051s) [122.493953] Starting dynamic subtest: ccs0 [123.677398] Dynamic subtest ccs0: SUCCESS (1.193s) [123.679797] Subtest busy-hang: SUCCESS (9.719s) [123.788801] [012/130] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [123.903504] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [128.153736] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.253s) [128.316178] [013/130] (889s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [128.415582] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [128.419642] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [128.502308] [014/130] (889s left) drm_fdinfo (busy) [128.542299] Starting subtest: busy [128.544622] Starting dynamic subtest: rcs0 [128.568993] Dynamic subtest rcs0: SKIP (0.024s) [128.575983] Starting dynamic subtest: bcs0 [128.580493] Dynamic subtest bcs0: SKIP (0.000s) [128.587295] Starting dynamic subtest: vcs0 [128.591318] Dynamic subtest vcs0: SKIP (0.000s) [128.598226] Starting dynamic subtest: vcs1 [128.602662] Dynamic subtest vcs1: SKIP (0.000s) [128.611523] Starting dynamic subtest: vecs0 [128.616036] Dynamic subtest vecs0: SKIP (0.000s) [128.623201] Starting dynamic subtest: ccs0 [128.627606] Dynamic subtest ccs0: SKIP (0.000s) [128.632593] Subtest busy: SKIP (0.026s) [128.660347] [015/130] (889s left) gem_exec_store (cachelines) [128.722995] Starting subtest: cachelines [128.725331] Starting dynamic subtest: rcs0 [128.791985] Dynamic subtest rcs0: SUCCESS (0.071s) [128.802034] Starting dynamic subtest: bcs0 [128.843274] Dynamic subtest bcs0: SUCCESS (0.051s) [128.852520] Starting dynamic subtest: vcs0 [128.904997] Dynamic subtest vcs0: SUCCESS (0.061s) [128.914321] Starting dynamic subtest: vcs1 [128.969378] Dynamic subtest vcs1: SUCCESS (0.063s) [128.982875] Starting dynamic subtest: vecs0 [129.034829] Dynamic subtest vecs0: SUCCESS (0.065s) [129.044230] Starting dynamic subtest: ccs0 [129.103474] Dynamic subtest ccs0: SUCCESS (0.068s) [129.105597] Subtest cachelines: SUCCESS (0.382s) [129.275197] [016/130] (888s left) gem_softpin (overlap) [129.324577] Starting subtest: overlap [130.181878] Subtest overlap: SUCCESS (0.856s) [130.308310] [017/130] (887s left) gem_softpin (allocator-fork) [130.363039] Starting subtest: allocator-fork [132.584625] Subtest allocator-fork: SUCCESS (2.220s) [132.698179] [018/130] (885s left) kms_flip (flip-vs-absolute-wf_vblank) [132.800305] Starting subtest: flip-vs-absolute-wf_vblank [132.802580] Starting dynamic subtest: A-eDP1 [141.808435] Dynamic subtest A-eDP1: SUCCESS (9.008s) [141.816489] Starting dynamic subtest: B-eDP1 [150.734923] Dynamic subtest B-eDP1: SUCCESS (8.925s) [150.744329] Starting dynamic subtest: C-eDP1 [159.651767] Dynamic subtest C-eDP1: SUCCESS (8.915s) [159.659193] Starting dynamic subtest: D-eDP1 [168.580675] Dynamic subtest D-eDP1: SUCCESS (8.927s) [168.585311] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.783s) [169.793821] [019/130] (848s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [169.892189] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [169.896120] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [169.994462] [020/130] (847s left) kms_psr (psr-sprite-mmap-cpu) [170.089176] Starting subtest: psr-sprite-mmap-cpu [170.091544] Starting dynamic subtest: eDP-1 [171.805999] Dynamic subtest eDP-1: SUCCESS (1.716s) [171.808315] Subtest psr-sprite-mmap-cpu: SUCCESS (1.717s) [172.641442] [021/130] (845s left) api_intel_bb (object-noreloc-purge-cache-simple) [172.700220] Starting subtest: object-noreloc-purge-cache-simple [172.704801] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s) [172.837275] [022/130] (845s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [177.884470] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [177.889071] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s) [178.734159] [023/130] (839s left) kms_plane_cursor (primary) [178.832966] Starting subtest: primary [178.837480] Starting dynamic subtest: pipe-A-eDP-1-size-64 [181.591283] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.756s) [181.613315] Starting dynamic subtest: pipe-A-eDP-1-size-128 [184.368801] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.761s) [184.395330] Starting dynamic subtest: pipe-A-eDP-1-size-256 [187.192141] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.804s) [187.506743] Starting dynamic subtest: pipe-B-eDP-1-size-64 [191.018896] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.522s) [191.041561] Starting dynamic subtest: pipe-B-eDP-1-size-128 [193.831218] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.793s) [193.854188] Starting dynamic subtest: pipe-B-eDP-1-size-256 [196.621148] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.771s) [196.935217] Starting dynamic subtest: pipe-C-eDP-1-size-64 [200.098337] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.172s) [200.123566] Starting dynamic subtest: pipe-C-eDP-1-size-128 [202.487703] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.368s) [202.514888] Starting dynamic subtest: pipe-C-eDP-1-size-256 [204.911555] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.403s) [205.224136] Starting dynamic subtest: pipe-D-eDP-1-size-64 [208.316990] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.102s) [208.343132] Starting dynamic subtest: pipe-D-eDP-1-size-128 [210.730333] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.391s) [210.753664] Starting dynamic subtest: pipe-D-eDP-1-size-256 [213.162738] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.414s) [213.471484] Subtest primary: SUCCESS (34.635s) [214.250686] [024/130] (803s left) gem_ctx_persistence (engines-queued) [214.312239] Starting subtest: engines-queued [214.314511] Starting dynamic subtest: rcs0 [214.421763] Dynamic subtest rcs0: SUCCESS (0.109s) [214.433333] Starting dynamic subtest: bcs0 [214.489590] Dynamic subtest bcs0: SUCCESS (0.063s) [214.498146] Starting dynamic subtest: vcs0 [215.883289] Dynamic subtest vcs0: SUCCESS (1.392s) [215.894369] Starting dynamic subtest: vcs1 [217.928489] Dynamic subtest vcs1: SUCCESS (2.043s) [217.939418] Starting dynamic subtest: vecs0 [219.912509] Dynamic subtest vecs0: SUCCESS (1.981s) [219.923264] Starting dynamic subtest: ccs0 [220.122364] Dynamic subtest ccs0: SUCCESS (0.209s) [220.125023] Subtest engines-queued: SUCCESS (5.810s) [220.192122] [025/130] (797s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [220.300899] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [220.305047] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [220.415583] [026/130] (797s left) gem_exec_params (invalid-bsd-ring) [220.484590] Starting subtest: invalid-bsd-ring [220.486957] Subtest invalid-bsd-ring: SUCCESS (0.000s) [220.589967] [027/130] (797s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [220.684249] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs [220.688731] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [221.774127] [028/130] (796s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [221.833882] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [221.835930] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [221.917157] [029/130] (796s left) i915_query (hwconfig_table) [221.983807] Starting subtest: hwconfig_table [222.284831] Subtest hwconfig_table: SUCCESS (0.001s) [222.313971] [030/130] (795s left) kms_rotation_crc (bad-tiling) [222.411237] Starting subtest: bad-tiling [222.415701] Subtest bad-tiling: SKIP (0.001s) [222.476990] [031/130] (795s left) gen9_exec_parse (unaligned-jump) [222.540266] Subtest unaligned-jump: SKIP (0.000s) [222.609232] [032/130] (795s left) kms_writeback (writeback-invalid-parameters) [222.712082] Subtest writeback-invalid-parameters: SKIP (0.000s) [222.746513] [033/130] (795s left) kms_cursor_edge_walk (256x256-top-edge) [222.844702] Starting subtest: 256x256-top-edge [222.846719] Starting dynamic subtest: pipe-A-eDP-1 [226.342469] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.496s) [226.350889] Starting dynamic subtest: pipe-D-eDP-1 [229.434668] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.088s) [229.436968] Subtest 256x256-top-edge: SUCCESS (6.587s) [230.248821] [034/130] (788s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [230.347421] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [230.349788] Starting dynamic subtest: pipe-A-eDP-1 [230.372377] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [230.380176] Starting dynamic subtest: pipe-B-eDP-1 [230.401476] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [230.409141] Starting dynamic subtest: pipe-C-eDP-1 [230.430688] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [230.438918] Starting dynamic subtest: pipe-D-eDP-1 [230.461098] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [230.465067] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s) [232.502615] [035/130] (785s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [232.620999] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [233.674692] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.055s) [233.802199] [036/130] (784s left) gem_exec_balancer (noheartbeat) [234.047571] Starting subtest: noheartbeat [234.052427] Subtest noheartbeat: SKIP (0.000s) [234.146515] [037/130] (784s left) kms_psr (fbc-psr-basic) [234.239729] Starting subtest: fbc-psr-basic [234.242064] Starting dynamic subtest: eDP-1 [234.246367] Dynamic subtest eDP-1: SKIP (0.000s) [234.251572] Subtest fbc-psr-basic: SKIP (0.001s) [234.302892] [038/130] (784s left) gem_exec_whisper (basic-contexts-priority) [234.367407] Starting subtest: basic-contexts-priority [259.061754] Subtest basic-contexts-priority: SUCCESS (24.691s) [259.236430] [039/130] (759s left) gem_exec_reloc (basic-cpu-read-active) [259.306346] Subtest basic-cpu-read-active: SKIP (0.000s) [259.378871] [040/130] (759s left) kms_setmode (clone-exclusive-crtc) [259.443307] Starting subtest: clone-exclusive-crtc [259.449971] Subtest clone-exclusive-crtc: SKIP (0.000s) [259.542339] [041/130] (758s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [259.642790] Starting subtest: crc-primary-suspend-y-tiled-ccs [259.645162] Starting dynamic subtest: pipe-A-eDP-1 [259.654238] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [259.662079] Starting dynamic subtest: pipe-B-eDP-1 [259.671221] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [259.678912] Starting dynamic subtest: pipe-C-eDP-1 [259.687633] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [259.695239] Starting dynamic subtest: pipe-D-eDP-1 [259.704183] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [259.709265] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s) [261.754206] [042/130] (756s left) gem_softpin (evict-single-offset) [261.819181] Starting subtest: evict-single-offset [288.981347] Subtest evict-single-offset: SUCCESS (27.159s) [289.055923] [043/130] (729s left) gem_exec_flush (basic-wb-set-default) [289.166482] Starting subtest: basic-wb-set-default [294.648833] Subtest basic-wb-set-default: SUCCESS (5.482s) [294.831497] [044/130] (723s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [294.933561] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [294.937965] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [295.022190] [045/130] (723s left) gem_set_tiling_vs_blt (tiled-to-tiled) [295.096149] Subtest tiled-to-tiled: SKIP (0.000s) [295.177985] [046/130] (723s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [295.283086] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [299.596823] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.320s) [299.715542] [047/130] (718s left) kms_pm_dc (dc3co-vpb-simulation) [300.834620] Starting subtest: dc3co-vpb-simulation [309.906534] Subtest dc3co-vpb-simulation: SKIP (9.066s) [310.038245] [048/130] (708s left) i915_module_load (resize-bar) [310.075304] Starting subtest: resize-bar [310.085295] Subtest resize-bar: SKIP (0.007s) [310.119421] [049/130] (708s left) vgem_basic (sysfs) [310.205937] Starting subtest: sysfs [310.208358] Subtest sysfs: SUCCESS (0.000s) [310.251854] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true [310.255126] [050/130] (708s left) kms_atomic_interruptible (legacy-pageflip) [310.353823] Starting subtest: legacy-pageflip [310.356125] Starting dynamic subtest: pipe-A-eDP-1 [317.749791] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.394s) [317.752397] Subtest legacy-pageflip: SUCCESS (7.396s) [318.570121] [051/130] (700s left) kms_prop_blob (invalid-get-prop-any) [318.630997] Starting subtest: invalid-get-prop-any [318.633058] Subtest invalid-get-prop-any: SUCCESS (0.000s) [318.733519] [052/130] (700s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [318.835669] Starting subtest: fbc-rgb565-draw-blt [321.964895] Subtest fbc-rgb565-draw-blt: SUCCESS (3.134s) [322.083036] [053/130] (696s left) syncobj_wait (single-wait-all-submitted) [322.144074] Starting subtest: single-wait-all-submitted [322.254429] Subtest single-wait-all-submitted: SUCCESS (0.108s) [322.327709] [054/130] (696s left) perf_pmu (multi-client) [322.370742] Starting subtest: multi-client [322.372981] Starting dynamic subtest: rcs0 [323.443530] Dynamic subtest rcs0: SUCCESS (1.071s) [323.454439] Starting dynamic subtest: bcs0 [324.493791] Dynamic subtest bcs0: SUCCESS (1.048s) [324.504659] Starting dynamic subtest: vcs0 [325.545388] Dynamic subtest vcs0: SUCCESS (1.048s) [325.556859] Starting dynamic subtest: vcs1 [326.945880] Dynamic subtest vcs1: SUCCESS (1.399s) [326.957616] Starting dynamic subtest: vecs0 [328.929250] Dynamic subtest vecs0: SUCCESS (1.982s) [328.939213] Starting dynamic subtest: ccs0 [330.939440] Dynamic subtest ccs0: SUCCESS (1.984s) [330.941535] Subtest multi-client: SUCCESS (8.544s) [331.022191] [055/130] (687s left) kms_getfb (getfb-handle-closed) [331.078368] Starting subtest: getfb-handle-closed [331.080782] Subtest getfb-handle-closed: SUCCESS (0.000s) [331.187053] [056/130] (687s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [331.311240] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [332.146042] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.836s) [332.343238] [057/130] (686s left) gem_exec_params (dr4-dirt) [332.413621] Starting subtest: DR4-dirt [332.415929] Subtest DR4-dirt: SUCCESS (0.000s) [332.519148] [058/130] (686s left) kms_cursor_crc (cursor-rapid-movement-512x512) [332.769347] Starting subtest: cursor-rapid-movement-512x512 [332.773786] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [332.932599] [059/130] (686s left) gem_exec_fence (syncobj-timeline-invalid-wait) [333.481732] Starting subtest: syncobj-timeline-invalid-wait [333.484229] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [334.978212] [060/130] (684s left) gem_exec_fence (expired-history) [335.396676] Starting subtest: expired-history [342.677125] Subtest expired-history: SUCCESS (7.281s) [343.274591] [061/130] (675s left) kms_psr (psr2-dpms) [343.378202] Starting subtest: psr2-dpms [343.380485] Starting dynamic subtest: eDP-1 [346.210301] Dynamic subtest eDP-1: SUCCESS (2.830s) [346.212179] Subtest psr2-dpms: SUCCESS (2.831s) [347.071482] [062/130] (672s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [347.133904] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [347.190568] [063/130] (672s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [347.251512] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [347.358477] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s) [347.427978] [064/130] (671s left) kms_addfb_basic (bad-pitch-1024) [347.475687] Starting subtest: bad-pitch-1024 [347.478184] Subtest bad-pitch-1024: SUCCESS (0.000s) [347.612709] [065/130] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [347.725441] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [347.729812] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [347.833718] [066/130] (671s left) kms_addfb_basic (basic-y-tiled-legacy) [347.884144] Starting subtest: basic-y-tiled-legacy [347.888610] Subtest basic-y-tiled-legacy: SKIP (0.000s) [348.004904] [067/130] (671s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [348.112952] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [348.924861] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.814s) [349.163538] [068/130] (670s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [349.283480] Starting subtest: cursorA-vs-flipA-toggle [360.425045] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.143s) [361.303751] [069/130] (658s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [361.396092] Starting subtest: primary-y-tiled-reflect-x-0 [361.468989] Subtest primary-y-tiled-reflect-x-0: SKIP (0.070s) [361.564056] [070/130] (657s left) kms_invalid_mode (bad-vsync-start) [361.654847] Starting subtest: bad-vsync-start [361.657639] Starting dynamic subtest: pipe-A-eDP-1 [361.935875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s) [361.946394] Starting dynamic subtest: pipe-B-eDP-1 [361.948630] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [361.956162] Starting dynamic subtest: pipe-C-eDP-1 [361.958447] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [361.966323] Starting dynamic subtest: pipe-D-eDP-1 [361.968271] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [361.970136] Subtest bad-vsync-start: SUCCESS (0.291s) [362.724027] [071/130] (656s left) gem_tiled_wb [362.836198] [072/130] (656s left) kms_getfb (getfb2-handle-not-fb) [362.891795] Starting subtest: getfb2-handle-not-fb [362.929912] Subtest getfb2-handle-not-fb: SUCCESS (0.041s) [363.036436] [073/130] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [363.140673] Starting subtest: fbcpsr-2p-rte [363.144644] Subtest fbcpsr-2p-rte: SKIP (0.000s) [363.247973] [074/130] (656s left) kms_cursor_crc (cursor-offscreen-64x64) [363.409706] Starting subtest: cursor-offscreen-64x64 [363.415688] Starting dynamic subtest: pipe-A-eDP-1 [365.376506] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.962s) [365.404528] Starting dynamic subtest: pipe-D-eDP-1 [367.971064] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.573s) [367.973782] Subtest cursor-offscreen-64x64: SUCCESS (4.561s) [368.791639] [075/130] (650s left) gem_basic (multigpu-create-close) [368.852632] Starting subtest: multigpu-create-close [368.857258] Subtest multigpu-create-close: SKIP (0.000s) [368.969468] [076/130] (650s left) kms_flip (flip-vs-rmfb) [369.068325] Starting subtest: flip-vs-rmfb [369.070667] Starting dynamic subtest: A-eDP1 [377.777625] Dynamic subtest A-eDP1: SUCCESS (8.708s) [377.787831] Starting dynamic subtest: B-eDP1 [386.503578] Dynamic subtest B-eDP1: SUCCESS (8.724s) [386.512839] Starting dynamic subtest: C-eDP1 [395.223285] Dynamic subtest C-eDP1: SUCCESS (8.719s) [395.230872] Starting dynamic subtest: D-eDP1 [403.848132] Dynamic subtest D-eDP1: SUCCESS (8.623s) [403.852523] Subtest flip-vs-rmfb: SUCCESS (34.785s) [405.020421] [077/130] (614s left) gem_create (create-size-update) [405.093563] Starting subtest: create-size-update [405.095597] Subtest create-size-update: SUCCESS (0.000s) [405.296345] [078/130] (614s left) template (b) [405.354505] Starting subtest: B [405.356708] Subtest B: SUCCESS (0.000s) [405.441221] [079/130] (614s left) gem_exec_schedule (implicit-write-read) [405.505732] Starting subtest: implicit-write-read [405.507738] Starting dynamic subtest: rcs0 [405.599232] Dynamic subtest rcs0: SUCCESS (0.104s) [405.607713] Starting dynamic subtest: vcs0 [405.678831] Dynamic subtest vcs0: SUCCESS (0.079s) [405.688855] Starting dynamic subtest: vcs1 [405.752252] Dynamic subtest vcs1: SUCCESS (0.073s) [405.760081] Starting dynamic subtest: vecs0 [405.833745] Dynamic subtest vecs0: SUCCESS (0.080s) [405.846934] Starting dynamic subtest: ccs0 [405.924239] Dynamic subtest ccs0: SUCCESS (0.090s) [405.926673] Subtest implicit-write-read: SUCCESS (0.430s) [407.048158] [080/130] (612s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [407.154630] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [407.159029] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [407.249258] [081/130] (612s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [407.309817] Starting subtest: yf-tiled-ccs-to-y-tiled [407.314289] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [407.486237] [082/130] (612s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt) [407.582422] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt [407.586827] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [407.689891] [083/130] (612s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [407.797289] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [407.801496] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [407.882895] [084/130] (612s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [408.001297] Starting subtest: 2x-cursor-vs-flip-legacy [408.005274] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s) [408.131860] [085/130] (611s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt) [408.233862] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt [411.443493] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (3.211s) [411.581527] [086/130] (608s left) gem_exec_reloc (basic-write-gtt) [411.654844] Subtest basic-write-gtt: SKIP (0.000s) [411.737634] [087/130] (608s left) kms_flip (2x-flip-vs-modeset-vs-hang) [411.836457] Starting subtest: 2x-flip-vs-modeset-vs-hang [411.846990] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s) [411.921015] [088/130] (608s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [412.012358] Starting subtest: invalidate-primary-flip-overlay [422.753745] Subtest invalidate-primary-flip-overlay: SUCCESS (10.743s) [422.884467] [089/130] (597s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25) [422.984715] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25 [422.986651] Starting dynamic subtest: pipe-A [423.001451] Dynamic subtest pipe-A: SKIP (0.011s) [423.009935] Starting dynamic subtest: pipe-B [423.021703] Dynamic subtest pipe-B: SKIP (0.020s) [423.029940] Starting dynamic subtest: pipe-C [423.042907] Dynamic subtest pipe-C: SKIP (0.021s) [423.050543] Starting dynamic subtest: pipe-D [423.063198] Dynamic subtest pipe-D: SKIP (0.020s) [423.066771] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.074s) [423.161741] [090/130] (596s left) kms_big_fb (y-tiled-8bpp-rotate-0) [423.260823] Starting subtest: y-tiled-8bpp-rotate-0 [423.264245] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [423.369149] [091/130] (596s left) prime_vgem (busy) [423.459778] Starting subtest: busy [423.461494] Starting dynamic subtest: rcs0 [423.524731] Dynamic subtest rcs0: SUCCESS (0.067s) [423.533456] Starting dynamic subtest: bcs0 [423.580661] Dynamic subtest bcs0: SUCCESS (0.055s) [423.588555] Starting dynamic subtest: vcs0 [423.624145] Dynamic subtest vcs0: SUCCESS (0.043s) [423.631881] Starting dynamic subtest: vcs1 [423.667582] Dynamic subtest vcs1: SUCCESS (0.043s) [423.675533] Starting dynamic subtest: vecs0 [423.713598] Dynamic subtest vecs0: SUCCESS (0.045s) [423.721614] Starting dynamic subtest: ccs0 [423.760452] Dynamic subtest ccs0: SUCCESS (0.046s) [423.762315] Subtest busy: SUCCESS (0.304s) [423.883711] [092/130] (596s left) kms_chamelium_edid (dp-edid-resolution-list) [424.268188] Subtest dp-edid-resolution-list: SKIP (0.000s) [425.054905] [093/130] (595s left) kms_color (ctm-negative) [425.143166] Starting subtest: ctm-negative [425.145454] Starting dynamic subtest: pipe-A-eDP-1 [425.838894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s) [425.849812] Starting dynamic subtest: pipe-B-eDP-1 [427.241144] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.401s) [427.250248] Starting dynamic subtest: pipe-C-eDP-1 [428.518583] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.277s) [428.526671] Starting dynamic subtest: pipe-D-eDP-1 [429.851772] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [429.853885] Subtest ctm-negative: SUCCESS (4.706s) [430.678101] [094/130] (589s left) gem_mmap_gtt (basic-copy) [430.741816] Subtest basic-copy: SKIP (0.000s) [430.800751] [095/130] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [430.896717] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [430.901186] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [430.999143] [096/130] (589s left) i915_pm_sseu (full-enable) [431.062431] Subtest full-enable: SKIP (0.000s) [431.145238] [097/130] (589s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [431.207072] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [431.209365] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [431.324655] [098/130] (589s left) gem_lmem_swapping (verify) [431.364315] Subtest verify: SKIP (0.000s) [431.421366] [099/130] (589s left) kms_chamelium_frames (hdmi-crc-multiple) [431.811543] Subtest hdmi-crc-multiple: SKIP (0.000s) [432.582828] [100/130] (587s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [432.693290] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [435.697054] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.008s) [435.843447] [101/130] (584s left) gem_ctx_sseu (mmap-args) [435.911747] Subtest mmap-args: SKIP (0.000s) [436.000941] [102/130] (584s left) gem_ctx_persistence (many-contexts) [436.058313] Starting subtest: many-contexts [481.284908] Subtest many-contexts: SUCCESS (45.224s) [481.357761] [103/130] (539s left) perf (invalid-open-flags) [481.468281] Starting subtest: invalid-open-flags [481.470550] Subtest invalid-open-flags: SUCCESS (0.000s) [481.502541] [104/130] (539s left) kms_pm_rpm (dpms-non-lpsp) [483.049406] Starting subtest: dpms-non-lpsp [483.053888] Subtest dpms-non-lpsp: SKIP (0.000s) [483.761760] [105/130] (536s left) gem_eio (in-flight-contexts-10ms) [483.947512] Starting subtest: in-flight-contexts-10ms [495.925566] Subtest in-flight-contexts-10ms: SUCCESS (11.975s) [496.115354] [106/130] (524s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [496.219752] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [496.224367] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [496.318098] [107/130] (524s left) gem_pwrite (basic-self) [496.377542] Subtest basic-self: SKIP (0.000s) [496.425650] [108/130] (524s left) gem_mmap_offset (bad-object) [496.482839] Starting subtest: bad-object [496.485206] Subtest bad-object: SUCCESS (0.001s) [496.594497] [109/130] (524s left) syncobj_wait (multi-wait-all-for-submit-signaled) [496.651691] Starting subtest: multi-wait-all-for-submit-signaled [496.654209] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [496.756656] [110/130] (524s left) gem_exec_schedule (promotion) [496.828083] Starting subtest: promotion [496.830048] Starting dynamic subtest: rcs0 [496.923720] Dynamic subtest rcs0: SUCCESS (0.104s) [496.935137] Starting dynamic subtest: vcs0 [497.002070] Dynamic subtest vcs0: SUCCESS (0.078s) [497.012564] Starting dynamic subtest: vcs1 [497.082741] Dynamic subtest vcs1: SUCCESS (0.080s) [497.092353] Starting dynamic subtest: vecs0 [497.158293] Dynamic subtest vecs0: SUCCESS (0.075s) [497.169605] Starting dynamic subtest: ccs0 [497.246137] Dynamic subtest ccs0: SUCCESS (0.088s) [497.248239] Subtest promotion: SUCCESS (0.427s) [498.080743] [111/130] (522s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [498.140499] Starting subtest: etime-multi-wait-available-unsubmitted [498.246237] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s) [498.313732] [112/130] (522s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [498.423170] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [498.427211] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [498.504207] [113/130] (522s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [498.601129] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [503.829230] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (5.232s) [503.937056] [114/130] (517s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [504.034077] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [504.036311] Starting dynamic subtest: pipe-A-eDP-1 [504.058572] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [504.067420] Starting dynamic subtest: pipe-B-eDP-1 [504.088813] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [504.097206] Starting dynamic subtest: pipe-C-eDP-1 [504.119296] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [504.127326] Starting dynamic subtest: pipe-D-eDP-1 [504.149073] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [504.154611] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [506.229113] [115/130] (514s left) gem_userptr_blits (stress-mm-invalidate-close) [506.300602] Starting subtest: stress-mm-invalidate-close [508.448661] Subtest stress-mm-invalidate-close: SUCCESS (2.149s) [508.582051] [116/130] (512s left) gem_caching (reads) [508.650944] Subtest reads: SKIP (0.000s) [508.729685] [117/130] (512s left) kms_psr (fbc-psr-primary-mmap-gtt) [508.838062] Starting subtest: fbc-psr-primary-mmap-gtt [508.840336] Starting dynamic subtest: eDP-1 [508.844723] Dynamic subtest eDP-1: SKIP (0.000s) [508.849199] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s) [508.904285] [118/130] (512s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling) [509.004079] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling [509.006268] Starting dynamic subtest: pipe-A-default-mode [510.165291] Dynamic subtest pipe-A-default-mode: SKIP (1.156s) [510.169660] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.159s) [510.326622] [119/130] (510s left) gem_softpin (evict-active) [510.392605] Starting subtest: evict-active [510.398677] Subtest evict-active: SUCCESS (0.006s) [510.542770] [120/130] (510s left) kms_force_connector_basic (prune-stale-modes) [510.625608] Starting subtest: prune-stale-modes [510.912545] Subtest prune-stale-modes: SUCCESS (0.287s) [511.061280] [121/130] (510s left) gem_userptr_blits (process-exit-busy) [511.129591] Starting subtest: process-exit-busy [511.141919] Subtest process-exit-busy: SUCCESS (0.013s) [511.261368] [122/130] (509s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [516.340634] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [516.343054] Starting dynamic subtest: pipe-A-eDP-1 [528.033998] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.692s) [528.042914] Starting dynamic subtest: pipe-B-eDP-1 [539.734712] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.698s) [539.737097] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.394s) [540.562897] [123/130] (480s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [540.664063] Starting subtest: plane-downscale-factor-0-5-with-modifiers [540.666244] Starting dynamic subtest: pipe-A [540.674984] Dynamic subtest pipe-A: SKIP (0.004s) [540.684108] Starting dynamic subtest: pipe-B [540.693190] Dynamic subtest pipe-B: SKIP (0.015s) [540.701510] Starting dynamic subtest: pipe-C [540.710604] Dynamic subtest pipe-C: SKIP (0.015s) [540.718921] Starting dynamic subtest: pipe-D [540.727754] Dynamic subtest pipe-D: SKIP (0.015s) [540.732235] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.050s) [540.804809] [124/130] (480s left) kms_draw_crc (draw-method-render) [540.909806] Starting subtest: draw-method-render [540.911927] Starting dynamic subtest: xrgb8888-untiled [541.136531] Dynamic subtest xrgb8888-untiled: SUCCESS (0.228s) [541.145394] Starting dynamic subtest: rgb565-untiled [541.347751] Dynamic subtest rgb565-untiled: SUCCESS (0.211s) [541.356604] Starting dynamic subtest: xrgb2101010-untiled [541.547519] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.200s) [541.555881] Starting dynamic subtest: xbgr16161616f-untiled [541.791611] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s) [541.800753] Starting dynamic subtest: xrgb8888-xtiled [541.925086] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [541.933510] Starting dynamic subtest: rgb565-xtiled [542.047269] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [542.055986] Starting dynamic subtest: xrgb2101010-xtiled [542.158596] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [542.167043] Starting dynamic subtest: xbgr16161616f-xtiled [542.292089] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [542.300087] Starting dynamic subtest: xrgb8888-4tiled [542.414133] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s) [542.423647] Starting dynamic subtest: rgb565-4tiled [542.525612] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s) [542.534288] Starting dynamic subtest: xrgb2101010-4tiled [542.636196] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s) [542.649247] Starting dynamic subtest: xbgr16161616f-4tiled [542.780608] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [542.782501] Subtest draw-method-render: SUCCESS (1.873s) [542.902125] [125/130] (478s left) kms_psr (fbc-pr-primary-render) [542.997053] Starting subtest: fbc-pr-primary-render [543.000865] Subtest fbc-pr-primary-render: SKIP (0.000s) [543.085256] [126/130] (478s left) kms_lease (lease-invalid-connector) [543.185724] Starting subtest: lease-invalid-connector [543.187685] Starting dynamic subtest: pipe-A-eDP-1 [543.189563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [543.198131] Starting dynamic subtest: pipe-B-eDP-1 [543.199966] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [543.208049] Starting dynamic subtest: pipe-C-eDP-1 [543.209660] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [543.217281] Starting dynamic subtest: pipe-D-eDP-1 [543.219091] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [543.220895] Subtest lease-invalid-connector: SUCCESS (0.004s) [543.253516] [127/130] (478s left) gem_wait (wait) [543.324111] Starting subtest: wait [543.326129] Starting dynamic subtest: all-engines [544.936897] Dynamic subtest all-engines: SUCCESS (1.611s) [544.948522] Starting dynamic subtest: rcs0 [545.984638] Dynamic subtest rcs0: SUCCESS (1.047s) [545.994438] Starting dynamic subtest: bcs0 [547.033050] Dynamic subtest bcs0: SUCCESS (1.046s) [547.044040] Starting dynamic subtest: vcs0 [548.079190] Dynamic subtest vcs0: SUCCESS (1.045s) [548.089707] Starting dynamic subtest: vcs1 [549.124083] Dynamic subtest vcs1: SUCCESS (1.043s) [549.134856] Starting dynamic subtest: vecs0 [550.170908] Dynamic subtest vecs0: SUCCESS (1.044s) [550.181681] Starting dynamic subtest: ccs0 [551.220138] Dynamic subtest ccs0: SUCCESS (1.047s) [551.222557] Subtest wait: SUCCESS (7.896s) [551.421154] [128/130] (470s left) kms_cursor_crc (cursor-offscreen-256x256) [551.642693] Starting subtest: cursor-offscreen-256x256 [551.645107] Starting dynamic subtest: pipe-A-eDP-1 [553.602787] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.955s) [553.629581] Starting dynamic subtest: pipe-D-eDP-1 [556.271118] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.648s) [556.273546] Subtest cursor-offscreen-256x256: SUCCESS (4.627s) [557.059552] [129/130] (464s left) gem_mmap_wc (set-cache-level) [557.117851] Subtest set-cache-level: SKIP (0.000s) [557.176316] [130/130] (464s left) sysfs_defaults (readonly) [557.239444] Starting subtest: readonly [557.241700] Starting dynamic subtest: vecs0 [557.244072] Dynamic subtest vecs0: SUCCESS (0.000s) [557.253408] Starting dynamic subtest: ccs0 [557.255515] Dynamic subtest ccs0: SUCCESS (0.000s) [557.263597] Starting dynamic subtest: vcs0 [557.265709] Dynamic subtest vcs0: SUCCESS (0.000s) [557.273602] Starting dynamic subtest: bcs0 [557.275642] Dynamic subtest bcs0: SUCCESS (0.000s) [557.283316] Starting dynamic subtest: rcs0 [557.285489] Dynamic subtest rcs0: SUCCESS (0.000s) [557.293065] Starting dynamic subtest: vcs1 [557.295145] Dynamic subtest vcs1: SUCCESS (0.000s) [557.297180] Subtest readonly: SUCCESS (0.005s) [557.361155] Closing watchdogs results: parsing output: 0/ for test: api_intel_allocator results: parsing output: 1/ for test: kms_flip_event_leak results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_vblank results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: kms_addfb_basic results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_flip_scaled_crc results: parsing output: 8/ for test: gem_exec_reloc results: parsing output: 9/ for test: drm_fdinfo results: parsing output: 10/ for test: perf_pmu results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: drm_fdinfo results: parsing output: 14/ for test: gem_exec_store results: parsing output: 15/ for test: gem_softpin results: parsing output: 16/ for test: gem_softpin results: parsing output: 17/ for test: kms_flip results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: api_intel_bb results: parsing output: 21/ for test: kms_psr2_sf results: parsing output: 22/ for test: kms_plane_cursor results: parsing output: 23/ for test: gem_ctx_persistence results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: gem_exec_params results: parsing output: 26/ for test: kms_ccs results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: i915_query results: parsing output: 29/ for test: kms_rotation_crc results: parsing output: 30/ for test: gen9_exec_parse results: parsing output: 31/ for test: kms_writeback results: parsing output: 32/ for test: kms_cursor_edge_walk results: parsing output: 33/ for test: kms_ccs results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: gem_exec_balancer results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: gem_exec_whisper results: parsing output: 38/ for test: gem_exec_reloc results: parsing output: 39/ for test: kms_setmode results: parsing output: 40/ for test: kms_ccs results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_exec_flush results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_set_tiling_vs_blt results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_pm_dc results: parsing output: 47/ for test: i915_module_load results: parsing output: 48/ for test: vgem_basic results: parsing output: 49/ for test: kms_atomic_interruptible results: parsing output: 50/ for test: kms_prop_blob results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: syncobj_wait results: parsing output: 53/ for test: perf_pmu results: parsing output: 54/ for test: kms_getfb results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: gem_exec_params results: parsing output: 57/ for test: kms_cursor_crc results: parsing output: 58/ for test: gem_exec_fence results: parsing output: 59/ for test: gem_exec_fence results: parsing output: 60/ for test: kms_psr results: parsing output: 61/ for test: gem_mmap_gtt results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: kms_cursor_legacy results: parsing output: 68/ for test: kms_rotation_crc results: parsing output: 69/ for test: kms_invalid_mode results: parsing output: 70/ for test: gem_tiled_wb results: parsing output: 71/ for test: kms_getfb results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_cursor_crc results: parsing output: 74/ for test: gem_basic results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: gem_create results: parsing output: 77/ for test: template results: parsing output: 78/ for test: gem_exec_schedule results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: gem_render_copy results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_cursor_legacy results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_exec_reloc results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: kms_psr_stress_test results: parsing output: 88/ for test: kms_plane_scaling results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: prime_vgem results: parsing output: 91/ for test: kms_chamelium_edid results: parsing output: 92/ for test: kms_color results: parsing output: 93/ for test: gem_mmap_gtt results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: i915_pm_sseu results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: gem_lmem_swapping results: parsing output: 98/ for test: kms_chamelium_frames results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_ctx_sseu results: parsing output: 101/ for test: gem_ctx_persistence results: parsing output: 102/ for test: perf results: parsing output: 103/ for test: kms_pm_rpm results: parsing output: 104/ for test: gem_eio results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: gem_pwrite results: parsing output: 107/ for test: gem_mmap_offset results: parsing output: 108/ for test: syncobj_wait results: parsing output: 109/ for test: gem_exec_schedule results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_ccs results: parsing output: 114/ for test: gem_userptr_blits results: parsing output: 115/ for test: gem_caching results: parsing output: 116/ for test: kms_psr results: parsing output: 117/ for test: kms_flip_scaled_crc results: parsing output: 118/ for test: gem_softpin results: parsing output: 119/ for test: kms_force_connector_basic results: parsing output: 120/ for test: gem_userptr_blits results: parsing output: 121/ for test: kms_psr2_sf results: parsing output: 122/ for test: kms_plane_scaling results: parsing output: 123/ for test: kms_draw_crc results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_lease results: parsing output: 126/ for test: gem_wait results: parsing output: 127/ for test: kms_cursor_crc results: parsing output: 128/ for test: gem_mmap_wc results: parsing output: 129/ for test: sysfs_defaults Done.