[58.428312] Initializing watchdogs [58.428376] /dev/watchdog0 [58.441946] [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.446310] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.448470] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.451701] [001/133] (960s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [58.526408] Starting subtest: multi-wait-for-submit-submitted-signaled [58.528703] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [58.650149] [002/133] (960s left) syncobj_wait (wait-for-submit-snapshot) [58.708221] Starting subtest: wait-for-submit-snapshot [58.790780] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [58.873868] [003/133] (960s left) gem_blits (basic) [58.943632] Starting subtest: basic [60.975099] Subtest basic: SUCCESS (2.034s) [61.105481] [004/133] (957s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [61.213736] Starting subtest: yf-tiled-8bpp-rotate-180 [61.218093] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [61.325215] [005/133] (957s left) kms_async_flips (test-cursor) [61.432548] Starting subtest: test-cursor [61.436776] Subtest test-cursor: SKIP (0.000s) [62.638991] [006/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [62.743724] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [62.748031] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [62.855526] [007/133] (956s left) kms_pm_rpm (pm-caching) [65.109630] Starting subtest: pm-caching [65.114649] Subtest pm-caching: SKIP (0.000s) [65.491188] [008/133] (953s left) gem_exercise_blt (fast-copy-emit) [65.547374] Starting subtest: fast-copy-emit [65.549700] Starting dynamic subtest: linear-smem-smem-emit [65.569124] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s) [65.578398] Starting dynamic subtest: xmajor-smem-smem-emit [65.585961] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [65.592859] Starting dynamic subtest: tile4-smem-smem-emit [65.602303] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s) [65.609133] Starting dynamic subtest: tile64-smem-smem-emit [65.618696] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s) [65.621088] Subtest fast-copy-emit: SUCCESS (0.072s) [65.776094] [009/133] (953s left) vgem_slow (nohang) [65.862895] Starting subtest: nohang [75.889500] Subtest nohang: SUCCESS (10.032s) [75.976260] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true [75.979295] [010/133] (943s left) kms_content_protection (lic-type-0) [76.118922] Starting subtest: lic-type-0 [76.123692] Subtest lic-type-0: SKIP (0.000s) [76.269781] [011/133] (943s left) kms_feature_discovery (display-3x) [76.367704] Starting subtest: display-3x [76.372200] Subtest display-3x: SKIP (0.000s) [76.458861] [012/133] (942s left) gem_mmap_gtt (cpuset-medium-copy-xy) [76.516972] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [76.574382] [013/133] (942s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [76.686054] Starting subtest: cursorA-vs-flipA-varying-size [87.838692] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.151s) [88.685507] [014/133] (930s left) gen7_exec_parse (load-register-reg) [88.749313] Subtest load-register-reg: SKIP (0.000s) [88.814545] [015/133] (930s left) gem_exec_fence (syncobj-wait) [89.223184] Starting subtest: syncobj-wait [90.935583] Subtest syncobj-wait: SUCCESS (1.711s) [91.304814] [016/133] (928s left) gem_mmap_wc (write-read-distinct) [91.367126] Subtest write-read-distinct: SKIP (0.000s) [91.428941] [017/133] (928s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [91.540677] Starting subtest: psr-rgb101010-draw-mmap-wc [98.532133] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.995s) [98.653850] [018/133] (920s left) kms_joiner (basic-ultra-joiner) [98.761410] Subtest basic-ultra-joiner: SKIP (0.000s) [98.829648] [019/133] (920s left) gem_ctx_isolation (nonpriv-switch) [98.902114] Starting subtest: nonpriv-switch [98.904566] Starting dynamic subtest: rcs0 [99.195593] Dynamic subtest rcs0: SUCCESS (0.293s) [99.205846] Starting dynamic subtest: bcs0 [99.480483] Dynamic subtest bcs0: SUCCESS (0.285s) [99.489367] Starting dynamic subtest: vcs0 [99.771373] Dynamic subtest vcs0: SUCCESS (0.291s) [99.780522] Starting dynamic subtest: vcs1 [101.128843] Dynamic subtest vcs1: SUCCESS (1.356s) [101.138324] Starting dynamic subtest: vecs0 [103.226363] Dynamic subtest vecs0: SUCCESS (2.097s) [103.236222] Starting dynamic subtest: ccs0 [105.283682] Dynamic subtest ccs0: SUCCESS (2.057s) [105.286081] Subtest nonpriv-switch: SUCCESS (6.382s) [105.534761] [020/133] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [105.641804] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [112.103449] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.463s) [112.274207] [021/133] (907s left) kms_cursor_crc (cursor-sliding-128x42) [112.489418] Starting subtest: cursor-sliding-128x42 [112.538984] Subtest cursor-sliding-128x42: SKIP (0.045s) [112.773390] [022/133] (906s left) gem_ctx_bad_destroy (invalid-default-ctx) [112.825700] Starting subtest: invalid-default-ctx [112.828047] Subtest invalid-default-ctx: SUCCESS (0.000s) [112.914277] [023/133] (906s left) kms_psr (fbc-psr-suspend) [113.001109] Starting subtest: fbc-psr-suspend [113.003065] Starting dynamic subtest: eDP-1 [113.007158] Dynamic subtest eDP-1: SKIP (0.000s) [113.011216] Subtest fbc-psr-suspend: SKIP (0.001s) [113.095070] [024/133] (906s left) api_intel_bb (reset-bb) [113.148647] Starting subtest: reset-bb [113.150524] Subtest reset-bb: SUCCESS (0.004s) [113.292972] [025/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [113.396748] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [113.400027] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [113.522718] [026/133] (906s left) gem_exec_schedule (u-fairslice-all) [113.593229] Starting subtest: u-fairslice-all [115.651277] Subtest u-fairslice-all: SUCCESS (2.059s) [117.003896] [027/133] (902s left) kms_flip (flip-vs-fences) [117.098083] Starting subtest: flip-vs-fences [117.102673] Subtest flip-vs-fences: SKIP (0.000s) [117.200042] [028/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [117.299283] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [118.223066] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.924s) [118.404031] [029/133] (901s left) gem_exec_capture (capture-recoverable) [118.454409] Starting subtest: capture-recoverable [118.458900] Subtest capture-recoverable: SUCCESS (0.003s) [118.603535] [030/133] (901s left) drm_read (empty-block) [118.744722] Starting subtest: empty-block [119.745552] Subtest empty-block: SUCCESS (1.000s) [119.893313] [031/133] (900s left) kms_rotation_crc (bad-tiling) [119.988325] Starting subtest: bad-tiling [119.992904] Subtest bad-tiling: SKIP (0.001s) [120.073116] [032/133] (900s left) gem_basic (create-close) [120.125040] Starting subtest: create-close [120.129586] Subtest create-close: SUCCESS (0.000s) [120.261557] [033/133] (899s left) kms_plane_multiple (2x-tiling-4) [120.349147] Starting subtest: 2x-tiling-4 [120.353701] Subtest 2x-tiling-4: SKIP (0.000s) [120.435843] [034/133] (899s left) kms_psr (fbc-psr-cursor-mmap-cpu) [120.529639] Starting subtest: fbc-psr-cursor-mmap-cpu [120.532039] Starting dynamic subtest: eDP-1 [120.536363] Dynamic subtest eDP-1: SKIP (0.000s) [120.540716] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [120.620557] [035/133] (899s left) kms_flip (2x-blocking-absolute-wf_vblank) [120.715330] Starting subtest: 2x-blocking-absolute-wf_vblank [120.726610] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [120.853097] [036/133] (899s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [120.941948] Starting subtest: multiplane-rotation-cropping-bottom [128.122606] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.182s) [128.269725] [037/133] (892s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [128.379149] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [128.382534] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [128.514982] [038/133] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [128.615458] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [128.619152] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [128.729199] [039/133] (891s left) kms_ccs (random-ccs-data-y-tiled-ccs) [128.827104] Starting subtest: random-ccs-data-y-tiled-ccs [128.828910] Starting dynamic subtest: pipe-A-eDP-1 [128.849384] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [128.858944] Starting dynamic subtest: pipe-B-eDP-1 [128.879171] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [128.885750] Starting dynamic subtest: pipe-C-eDP-1 [128.905144] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [128.911782] Starting dynamic subtest: pipe-D-eDP-1 [128.931667] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [128.935194] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s) [131.005089] [040/133] (889s left) gem_mmap_gtt (big-copy-xy) [131.064204] Subtest big-copy-XY: SKIP (0.000s) [131.126103] [041/133] (889s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [131.231233] Starting subtest: fbcpsr-farfromfence-mmap-gtt [131.235785] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [131.355979] [042/133] (889s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [131.470937] Starting subtest: fbc-rgb565-draw-pwrite [135.974731] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.507s) [137.191076] [043/133] (883s left) kms_cursor_edge_walk (256x256-top-bottom) [137.292219] Starting subtest: 256x256-top-bottom [137.294438] Starting dynamic subtest: pipe-A-eDP-1 [140.712990] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s) [140.721439] Starting dynamic subtest: pipe-D-eDP-1 [143.828350] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s) [143.830568] Subtest 256x256-top-bottom: SUCCESS (6.538s) [144.671307] [044/133] (875s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [144.789349] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [161.932062] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.143s) [162.746768] [045/133] (857s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [162.805350] Starting subtest: multi-wait-for-submit-available-submitted-signaled [162.807621] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [162.937054] [046/133] (857s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [163.033070] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [163.035259] Starting dynamic subtest: pipe-A-eDP-1 [163.057261] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [163.066146] Starting dynamic subtest: pipe-B-eDP-1 [163.087099] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [163.094663] Starting dynamic subtest: pipe-C-eDP-1 [163.115802] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [163.123666] Starting dynamic subtest: pipe-D-eDP-1 [163.147493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [163.152089] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [165.202774] [047/133] (855s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [165.295550] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [168.908919] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.617s) [170.114260] [048/133] (850s left) gem_exec_schedule (pi-distinct-iova) [170.289786] Starting subtest: pi-distinct-iova [170.292285] Starting dynamic subtest: rcs0 [170.360060] Dynamic subtest rcs0: SUCCESS (0.071s) [170.371427] Starting dynamic subtest: vcs0 [170.410341] Dynamic subtest vcs0: SUCCESS (0.049s) [170.418274] Starting dynamic subtest: vcs1 [170.463677] Dynamic subtest vcs1: SUCCESS (0.053s) [170.470921] Starting dynamic subtest: vecs0 [170.515796] Dynamic subtest vecs0: SUCCESS (0.050s) [170.524254] Starting dynamic subtest: ccs0 [170.575812] Dynamic subtest ccs0: SUCCESS (0.059s) [170.578193] Subtest pi-distinct-iova: SUCCESS (0.290s) [172.036403] [049/133] (848s left) kms_properties (colorop-properties-atomic) [172.114328] Starting subtest: colorop-properties-atomic [172.116654] Starting dynamic subtest: pipe-A-eDP-1 [172.473083] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s) [172.481952] Starting dynamic subtest: pipe-B-eDP-1 [173.536488] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.059s) [173.549985] Starting dynamic subtest: pipe-C-eDP-1 [174.570394] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.035s) [174.578687] Starting dynamic subtest: pipe-D-eDP-1 [175.612056] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.040s) [175.614538] Subtest colorop-properties-atomic: SUCCESS (3.497s) [176.438216] [050/133] (844s left) kms_setmode (invalid-clone-single-crtc) [176.499944] Starting subtest: invalid-clone-single-crtc [176.506215] Subtest invalid-clone-single-crtc: SKIP (0.000s) [176.615363] [051/133] (844s left) gem_tiled_blits (interruptible) [176.663457] Subtest interruptible: SKIP (0.000s) [176.741063] [052/133] (844s left) gem_mmap_offset (basic-uaf) [176.792411] Starting subtest: basic-uaf [176.794344] Subtest basic-uaf: SUCCESS (0.001s) [176.916379] [053/133] (844s left) gem_spin_batch (engines) [176.973136] Starting subtest: engines [176.975436] Starting dynamic subtest: rcs0 [180.215074] Dynamic subtest rcs0: SUCCESS (3.237s) [180.225873] Starting dynamic subtest: bcs0 [183.453755] Dynamic subtest bcs0: SUCCESS (3.235s) [183.461561] Starting dynamic subtest: vcs0 [186.689106] Dynamic subtest vcs0: SUCCESS (3.232s) [186.696812] Starting dynamic subtest: vcs1 [189.924256] Dynamic subtest vcs1: SUCCESS (3.233s) [189.933031] Starting dynamic subtest: vecs0 [193.161588] Dynamic subtest vecs0: SUCCESS (3.234s) [193.172316] Starting dynamic subtest: ccs0 [196.400974] Dynamic subtest ccs0: SUCCESS (3.236s) [196.403474] Subtest engines: SUCCESS (19.425s) [196.679776] [054/133] (824s left) i915_pm_rps (thresholds-park) [196.745186] Starting subtest: thresholds-park [196.749949] Subtest thresholds-park: SKIP (0.001s) [196.869675] [055/133] (824s left) i915_fb_tiling (basic-x-tiling) [196.914519] Subtest basic-x-tiling: SKIP (0.000s) [196.976180] [056/133] (824s left) prime_busy (hang-wait) [197.019916] Starting subtest: hang-wait [197.022286] Starting dynamic subtest: rcs0 [223.347363] Dynamic subtest rcs0: SUCCESS (26.324s) [223.356326] Starting dynamic subtest: bcs0 [230.498703] Dynamic subtest bcs0: SUCCESS (7.149s) [230.507795] Starting dynamic subtest: vcs0 [237.537710] Dynamic subtest vcs0: SUCCESS (7.035s) [237.547106] Starting dynamic subtest: vcs1 [244.514673] Dynamic subtest vcs1: SUCCESS (6.976s) [244.522248] Starting dynamic subtest: vecs0 [251.483988] Dynamic subtest vecs0: SUCCESS (6.967s) [251.493658] Starting dynamic subtest: ccs0 [265.387841] Dynamic subtest ccs0: SUCCESS (13.901s) [265.390294] Subtest hang-wait: SUCCESS (68.364s) [265.556458] [057/133] (755s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [265.668428] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [265.672698] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [265.826957] [058/133] (755s left) perf (non-zero-reason) [265.970253] Starting subtest: non-zero-reason [265.972288] Starting dynamic subtest: 0-rcs0 [271.263606] Dynamic subtest 0-rcs0: SUCCESS (5.293s) [271.275480] Starting dynamic subtest: 1-vcs0 [275.141122] Dynamic subtest 1-vcs0: SUCCESS (3.871s) [275.143292] Subtest non-zero-reason: SUCCESS (9.166s) [275.192936] [059/133] (746s left) gem_mmap_gtt (basic-small-copy-xy) [275.256863] Subtest basic-small-copy-XY: SKIP (0.000s) [275.322165] [060/133] (745s left) kms_chamelium_hpd (vga-hpd-fast) [275.712170] Subtest vga-hpd-fast: SKIP (0.000s) [276.505578] [061/133] (744s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [276.603814] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [277.705820] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.102s) [277.872882] [062/133] (743s left) device_reset (unbind-cold-reset-rebind) [277.920088] Starting subtest: unbind-cold-reset-rebind [277.923655] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [278.002432] [063/133] (743s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [278.070882] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [278.146081] [064/133] (743s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [278.237523] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [278.239463] Starting dynamic subtest: pipe-A-eDP-1 [278.533728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.271s) [278.541281] Starting dynamic subtest: pipe-B-eDP-1 [279.789863] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.248s) [279.797723] Starting dynamic subtest: pipe-C-eDP-1 [281.015405] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s) [281.025150] Starting dynamic subtest: pipe-D-eDP-1 [282.252212] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s) [282.254559] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.985s) [283.485563] [065/133] (737s left) prime_self_import (basic-with_one_bo) [283.519108] Starting subtest: basic-with_one_bo [283.536783] Subtest basic-with_one_bo: SUCCESS (0.019s) [283.658604] [066/133] (737s left) kms_big_fb (4-tiled-64bpp-rotate-180) [283.755478] Starting subtest: 4-tiled-64bpp-rotate-180 [285.300234] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.544s) [285.499336] [067/133] (736s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [285.556852] Starting subtest: etime-multi-wait-all-for-submit-submitted [285.663964] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s) [285.753100] [068/133] (735s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [285.854929] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [285.857196] Starting dynamic subtest: A-eDP1 [289.403617] Dynamic subtest A-eDP1: SUCCESS (3.545s) [289.411659] Starting dynamic subtest: B-eDP1 [292.591882] Dynamic subtest B-eDP1: SUCCESS (3.186s) [292.606147] Starting dynamic subtest: C-eDP1 [295.694124] Dynamic subtest C-eDP1: SUCCESS (3.104s) [295.703015] Starting dynamic subtest: D-eDP1 [298.800502] Dynamic subtest D-eDP1: SUCCESS (3.103s) [298.802787] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.946s) [299.615364] [069/133] (722s left) gem_mmap_wc (invalid-flags) [299.683866] Subtest invalid-flags: SKIP (0.000s) [299.745850] [070/133] (721s left) gem_pwrite (basic-self) [299.813379] Subtest basic-self: SKIP (0.000s) [299.883350] [071/133] (721s left) i915_drm_fdinfo (most-busy-check-all) [299.921337] Starting subtest: most-busy-check-all [299.923537] Starting dynamic subtest: rcs0 [299.928082] Dynamic subtest rcs0: SKIP (0.004s) [299.937025] Starting dynamic subtest: bcs0 [299.941356] Dynamic subtest bcs0: SKIP (0.000s) [299.949356] Starting dynamic subtest: vcs0 [299.953695] Dynamic subtest vcs0: SKIP (0.000s) [299.961054] Starting dynamic subtest: vcs1 [299.965271] Dynamic subtest vcs1: SKIP (0.000s) [299.973133] Starting dynamic subtest: vecs0 [299.977267] Dynamic subtest vecs0: SKIP (0.000s) [299.985303] Starting dynamic subtest: ccs0 [299.989551] Dynamic subtest ccs0: SKIP (0.000s) [299.993640] Subtest most-busy-check-all: SKIP (0.010s) [300.028790] [072/133] (721s left) gem_exec_fence (parallel) [300.234921] Starting subtest: parallel [300.237719] Starting dynamic subtest: rcs0 [302.381705] Dynamic subtest rcs0: SUCCESS (2.148s) [302.389451] Starting dynamic subtest: bcs0 [304.533228] Dynamic subtest bcs0: SUCCESS (2.150s) [304.542910] Starting dynamic subtest: vcs0 [306.684951] Dynamic subtest vcs0: SUCCESS (2.151s) [306.694283] Starting dynamic subtest: vcs1 [308.835152] Dynamic subtest vcs1: SUCCESS (2.149s) [308.843800] Starting dynamic subtest: vecs0 [310.988116] Dynamic subtest vecs0: SUCCESS (2.152s) [310.996051] Starting dynamic subtest: ccs0 [313.141446] Dynamic subtest ccs0: SUCCESS (2.152s) [313.143479] Subtest parallel: SUCCESS (12.908s) [314.018864] [073/133] (707s left) perf (unprivileged-single-ctx-counters) [314.126033] Starting subtest: unprivileged-single-ctx-counters [314.130798] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [314.167815] [074/133] (707s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [314.225380] Starting subtest: etime-single-wait-available-unsubmitted [314.327226] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s) [314.431161] [075/133] (707s left) gem_exec_reloc (basic-wc-gtt-noreloc) [314.488474] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [314.561109] [076/133] (707s left) kms_lease (possible-crtcs-filtering) [314.655039] Starting subtest: possible-crtcs-filtering [314.659783] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [314.776650] [077/133] (707s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [314.858988] Starting subtest: extended-pageflip-modeset-hang-oldfb [314.860945] Starting dynamic subtest: pipe-A [322.765101] Dynamic subtest pipe-A: SUCCESS (7.904s) [322.775251] Starting dynamic subtest: pipe-D [331.403182] Dynamic subtest pipe-D: SUCCESS (8.635s) [331.405421] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.543s) [332.274652] [078/133] (689s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [332.380513] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [332.384683] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [332.497951] [079/133] (689s left) syncobj_basic (bad-pad-handle-to-fd) [332.552271] Starting subtest: bad-pad-handle-to-fd [332.554068] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [332.673953] [080/133] (689s left) gem_exec_flush (basic-wb-pro-default) [332.735070] Starting subtest: basic-wb-pro-default [338.185535] Subtest basic-wb-pro-default: SUCCESS (5.450s) [338.393431] [081/133] (683s left) gem_ctx_sseu (mmap-args) [338.461069] Subtest mmap-args: SKIP (0.000s) [338.548051] [082/133] (683s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [338.667558] Starting subtest: nonblocking-modeset-vs-cursor-atomic [340.135708] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.469s) [340.941618] [083/133] (681s left) syncobj_wait (invalid-signal-one-illegal-handle) [341.004087] Starting subtest: invalid-signal-one-illegal-handle [341.006374] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [341.138360] [084/133] (681s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [341.233657] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [341.868351] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s) [342.063568] [085/133] (680s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [342.162021] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [342.164339] Starting dynamic subtest: pipe-A [342.284289] Dynamic subtest pipe-A: SKIP (0.118s) [342.293580] Starting dynamic subtest: pipe-B [343.502982] Dynamic subtest pipe-B: SKIP (1.217s) [343.512085] Starting dynamic subtest: pipe-C [344.650439] Dynamic subtest pipe-C: SUCCESS (1.154s) [344.658270] Starting dynamic subtest: pipe-D [345.802981] Dynamic subtest pipe-D: SUCCESS (1.152s) [345.805592] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.644s) [347.006430] [086/133] (675s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [347.112327] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [354.453365] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.344s) [354.621617] [087/133] (667s left) gem_pxp (reject-modify-context-protection-off-3) [354.749348] Starting subtest: reject-modify-context-protection-off-3 [354.751761] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s) [354.882724] [088/133] (667s left) syncobj_timeline (wait-all-for-submit-snapshot) [354.939984] Starting subtest: wait-all-for-submit-snapshot [355.018892] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s) [355.105128] [089/133] (667s left) kms_color (ctm-signed) [355.202154] Starting subtest: ctm-signed [355.204284] Starting dynamic subtest: pipe-A-eDP-1 [357.321501] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s) [357.330507] Starting dynamic subtest: pipe-B-eDP-1 [360.189075] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.868s) [360.198105] Starting dynamic subtest: pipe-C-eDP-1 [362.884096] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.691s) [362.894399] Starting dynamic subtest: pipe-D-eDP-1 [365.551643] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.665s) [365.553909] Subtest ctm-signed: SUCCESS (10.349s) [366.386384] [090/133] (656s left) gem_ccs (suspend-resume) [366.447805] Starting subtest: suspend-resume [366.451849] Subtest suspend-resume: SKIP (0.000s) [366.576516] [091/133] (655s left) kms_writeback (writeback-check-output) [366.675150] Subtest writeback-check-output: SKIP (0.000s) [366.716567] [092/133] (655s left) gem_exec_whisper (basic-normal-all) [366.785100] Starting subtest: basic-normal-all [369.038993] Subtest basic-normal-all: SUCCESS (2.255s) [369.238145] [093/133] (653s left) gem_partial_pwrite_pread (write-snoop) [369.299408] Subtest write-snoop: SKIP (0.000s) [369.380114] [094/133] (653s left) kms_vblank (ts-continuation-modeset-rpm) [369.482802] Starting subtest: ts-continuation-modeset-rpm [369.484637] Starting dynamic subtest: pipe-A-eDP-1 [371.971850] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.487s) [371.987244] Starting dynamic subtest: pipe-D-eDP-1 [374.229671] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s) [374.231941] Subtest ts-continuation-modeset-rpm: SUCCESS (4.746s) [375.127721] [095/133] (647s left) kms_frontbuffer_tracking (fbc-stridechange) [375.219743] Starting subtest: fbc-stridechange [378.547195] Subtest fbc-stridechange: SUCCESS (3.330s) [379.736466] [096/133] (642s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [384.685994] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [384.688428] Starting dynamic subtest: pipe-A-eDP-1 [385.490348] Dynamic subtest pipe-A-eDP-1: SKIP (0.801s) [385.499353] Starting dynamic subtest: pipe-B-eDP-1 [386.614447] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s) [386.619151] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.927s) [387.813948] [097/133] (634s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [387.915677] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [387.919979] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [388.037241] [098/133] (634s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [393.179281] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [393.181626] Starting dynamic subtest: pipe-A-eDP-1 [399.831427] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.650s) [399.840825] Starting dynamic subtest: pipe-B-eDP-1 [406.465960] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.633s) [406.468440] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.286s) [407.344638] [099/133] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [407.443890] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [407.448184] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [407.546540] [100/133] (615s left) kms_invalid_mode (bad-vsync-end) [407.642831] Starting subtest: bad-vsync-end [407.645180] Starting dynamic subtest: pipe-A-eDP-1 [407.929113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [407.938684] Starting dynamic subtest: pipe-B-eDP-1 [407.940869] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [407.949329] Starting dynamic subtest: pipe-C-eDP-1 [407.951706] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [407.960284] Starting dynamic subtest: pipe-D-eDP-1 [407.962468] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [407.964703] Subtest bad-vsync-end: SUCCESS (0.294s) [408.771076] [101/133] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [408.868706] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [408.873231] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [408.986341] [102/133] (613s left) gem_ctx_persistence (heartbeat-hang) [409.039882] Starting subtest: heartbeat-hang [409.044460] Subtest heartbeat-hang: SKIP (0.000s) [409.179538] [103/133] (613s left) kms_flip_tiling (flip-change-tiling) [409.273616] Starting subtest: flip-change-tiling [409.275976] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [409.446576] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.174s) [409.457628] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [409.580823] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [409.591138] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [409.713888] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [409.724056] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [409.857776] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [409.867634] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [410.001120] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [410.010134] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [410.146599] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s) [410.160060] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [410.292608] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s) [410.309679] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [410.401954] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [410.413901] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [410.547709] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [410.558691] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [410.680259] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.132s) [410.692182] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [410.823502] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [410.836471] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [410.995777] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.169s) [411.006651] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [411.129384] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [411.139328] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [411.263870] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [411.274736] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [411.385393] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s) [411.394398] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [411.529762] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [411.539863] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [411.701224] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.170s) [411.711834] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [411.845800] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [411.860673] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [411.991793] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.141s) [412.003656] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [412.124489] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s) [412.135955] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [412.257404] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.131s) [412.269200] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [412.379052] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s) [412.390176] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [412.522777] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s) [412.535707] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [412.667428] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [412.678632] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [412.811903] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [412.825660] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [412.956192] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.141s) [412.969547] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [413.101555] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [413.115635] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [413.245320] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.143s) [413.259476] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [413.367707] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.119s) [413.379044] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [413.512886] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s) [413.524056] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [413.656488] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [413.667771] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [413.801101] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [413.812478] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [413.945695] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [413.959143] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [414.089610] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.143s) [414.104340] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [414.234817] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s) [414.245902] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [414.356780] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s) [414.408358] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [415.629806] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.227s) [415.640052] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [415.775668] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s) [415.786770] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [415.908781] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [415.918538] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [416.052498] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [416.064362] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [416.196745] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [416.206862] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [416.340989] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [416.352948] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [416.474586] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [416.485857] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [416.585906] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s) [416.596782] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [416.720185] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [416.730741] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [416.862998] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [416.875550] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [417.007104] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [417.018918] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [417.141269] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.131s) [417.157089] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [417.273869] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [417.285919] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [417.408924] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [417.420944] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [417.519562] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [417.530320] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [417.663321] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [417.674082] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [417.806829] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [417.818118] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [417.951529] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [417.962856] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [418.098816] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [418.109705] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [418.229749] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s) [418.240509] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [418.374975] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [418.385265] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [418.507027] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.131s) [418.518305] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [418.651055] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s) [418.665120] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [418.818187] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.164s) [418.832546] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [418.962210] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [418.974262] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [419.107153] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [419.121809] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [419.251471] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [419.263031] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [419.407046] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.153s) [419.420988] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [419.529506] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.119s) [419.542851] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [419.673995] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [419.685413] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [419.818175] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [419.829443] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [419.962374] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [419.974784] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [420.106754] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [420.120389] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [420.251365] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s) [420.262041] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [420.396324] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s) [420.408060] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [420.518791] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.119s) [420.570935] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [421.761849] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.196s) [421.776973] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [421.861684] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [421.873101] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [421.961819] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s) [421.973786] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [422.072633] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [422.083969] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [422.221970] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.148s) [422.232042] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [422.333099] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [422.347065] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [422.444866] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.108s) [422.459301] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [422.556051] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s) [422.567951] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [422.666477] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [422.677281] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [422.777448] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [422.787604] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [422.888181] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s) [422.899400] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [422.988811] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s) [422.998136] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [423.088737] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [423.100045] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [423.188854] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [423.199522] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [423.288873] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [423.299085] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [423.388285] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s) [423.399116] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [423.499646] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s) [423.513882] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [423.610491] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [423.619506] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [423.711168] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s) [423.722954] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [423.810699] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s) [423.821441] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [423.911515] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s) [423.923382] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [424.022310] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s) [424.033293] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [424.132540] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s) [424.142067] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [424.243934] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s) [424.255761] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [424.355066] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.108s) [424.363465] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [424.465724] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [424.476428] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [424.566081] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.098s) [424.576978] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [424.677230] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s) [424.689678] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [424.788506] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s) [424.797948] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [424.899808] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s) [424.910251] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [424.999310] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s) [425.012129] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [425.110356] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s) [425.121512] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [425.221398] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s) [425.234782] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [425.332784] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s) [425.346972] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [425.444138] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s) [425.455147] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [425.555531] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s) [425.595027] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [426.788769] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.198s) [426.800615] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [426.888750] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [426.898057] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [426.988063] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s) [427.002539] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [427.146598] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.155s) [427.158619] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [427.255752] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [427.265100] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [427.366496] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [427.377976] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [427.467307] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [427.476634] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [427.567402] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [427.579040] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [427.667567] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [427.679027] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [427.767268] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.099s) [427.778475] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [427.877745] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [427.886933] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [427.989076] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s) [427.999689] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [428.089423] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [428.104186] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [428.200099] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.109s) [428.211308] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [428.299890] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [428.310115] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [428.411013] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [428.423510] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [428.522283] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [428.536552] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [428.632802] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.108s) [428.643453] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [428.733478] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s) [428.744272] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [428.845382] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s) [428.857203] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [428.955820] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.108s) [428.968168] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [429.066536] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [429.077151] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [429.177439] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [429.190172] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [429.288903] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s) [429.300026] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [429.388519] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s) [429.401588] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [429.499670] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [429.513070] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [429.610911] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [429.622211] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [429.721991] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s) [429.732699] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [429.833718] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s) [429.845433] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [429.944473] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s) [429.955613] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [430.055541] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [430.065220] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [430.166492] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s) [430.176544] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [430.277720] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s) [430.288549] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [430.428907] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.150s) [430.438474] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [430.578787] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.148s) [430.593227] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [430.689985] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [430.722857] Subtest flip-change-tiling: SUCCESS (21.452s) [431.903369] [104/133] (591s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [432.001446] Starting subtest: fbc-psr2-cursor-mmap-cpu [432.003654] Starting dynamic subtest: eDP-1 [432.008121] Dynamic subtest eDP-1: SKIP (0.000s) [432.012507] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [432.096523] [105/133] (590s left) kms_chamelium_frames (dp-crc-fast) [432.486349] Subtest dp-crc-fast: SKIP (0.000s) [433.307612] [106/133] (589s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [433.400318] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [433.402265] Starting dynamic subtest: pipe-A-eDP-1 [433.424386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s) [433.433205] Starting dynamic subtest: pipe-B-eDP-1 [433.454297] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s) [433.462730] Starting dynamic subtest: pipe-C-eDP-1 [433.483353] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s) [433.491708] Starting dynamic subtest: pipe-D-eDP-1 [433.512930] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s) [433.515237] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.089s) [435.723091] [107/133] (587s left) kms_colorop (plane-xr24-xr24-srgb_inv_eotf_lut) [435.854260] Subtest plane-XR24-XR24-srgb_inv_eotf_lut: SKIP (0.000s) [435.948924] [108/133] (587s left) kms_draw_crc (draw-method-pwrite) [436.043899] Starting subtest: draw-method-pwrite [436.045737] Starting dynamic subtest: xrgb8888-untiled [436.654071] Dynamic subtest xrgb8888-untiled: SUCCESS (0.611s) [436.662948] Starting dynamic subtest: rgb565-untiled [437.165450] Dynamic subtest rgb565-untiled: SUCCESS (0.510s) [437.174424] Starting dynamic subtest: xrgb2101010-untiled [437.765535] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.599s) [437.774491] Starting dynamic subtest: xbgr16161616f-untiled [438.565321] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.799s) [438.576211] Starting dynamic subtest: xrgb8888-xtiled [440.632305] Dynamic subtest xrgb8888-xtiled: SUCCESS (2.066s) [440.641147] Starting dynamic subtest: rgb565-xtiled [441.987431] Dynamic subtest rgb565-xtiled: SUCCESS (1.355s) [441.996256] Starting dynamic subtest: xrgb2101010-xtiled [444.031944] Dynamic subtest xrgb2101010-xtiled: SUCCESS (2.044s) [444.044528] Starting dynamic subtest: xbgr16161616f-xtiled [447.621173] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.588s) [447.630376] Starting dynamic subtest: xrgb8888-4tiled [448.876635] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.255s) [448.887487] Starting dynamic subtest: rgb565-4tiled [449.543354] Dynamic subtest rgb565-4tiled: SUCCESS (0.666s) [449.552684] Starting dynamic subtest: xrgb2101010-4tiled [450.799983] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.255s) [450.808932] Starting dynamic subtest: xbgr16161616f-4tiled [454.010247] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.209s) [454.012640] Subtest draw-method-pwrite: SUCCESS (17.967s) [454.137433] [109/133] (569s left) gem_exec_params (dr4-dirt) [454.197749] Starting subtest: DR4-dirt [454.200128] Subtest DR4-dirt: SUCCESS (0.000s) [454.314525] [110/133] (568s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [454.411592] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [454.413812] Starting dynamic subtest: pipe-A-default-mode [454.696758] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [454.701564] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.286s) [455.552257] [111/133] (567s left) kms_cursor_crc (cursor-random-64x21) [455.738919] Starting subtest: cursor-random-64x21 [455.791494] Subtest cursor-random-64x21: SKIP (0.047s) [456.031754] [112/133] (567s left) kms_big_fb (y-tiled-64bpp-rotate-270) [456.130331] Starting subtest: y-tiled-64bpp-rotate-270 [456.134431] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [456.246992] [113/133] (567s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [456.338774] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [463.621650] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.284s) [463.798550] [114/133] (559s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [463.887038] Starting subtest: plane-downscale-factor-0-5-with-rotation [463.889318] Starting dynamic subtest: pipe-A [463.907725] Dynamic subtest pipe-A: SKIP (0.017s) [463.917078] Starting dynamic subtest: pipe-B [463.938618] Dynamic subtest pipe-B: SKIP (0.029s) [463.947568] Starting dynamic subtest: pipe-C [463.969139] Dynamic subtest pipe-C: SKIP (0.030s) [463.979587] Starting dynamic subtest: pipe-D [464.001110] Dynamic subtest pipe-D: SKIP (0.033s) [464.005159] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.112s) [464.119517] [115/133] (559s left) kms_concurrent (multi-plane-atomic-lowres) [464.216751] Starting subtest: multi-plane-atomic-lowres [464.219116] Starting dynamic subtest: pipe-A-eDP-1 [464.723762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.505s) [464.726166] Subtest multi-plane-atomic-lowres: SUCCESS (0.507s) [465.596985] [116/133] (557s left) i915_pm_rpm (sysfs-read) [467.121791] Starting subtest: sysfs-read [468.286147] Subtest sysfs-read: SUCCESS (1.165s) [468.669471] [117/133] (554s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [468.732855] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [468.735201] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [468.856300] [118/133] (554s left) kms_universal_plane (universal-plane-functional) [468.957833] Starting subtest: universal-plane-functional [468.960171] Starting dynamic subtest: pipe-A-eDP-1 [472.898860] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.942s) [472.908235] Starting dynamic subtest: pipe-B-eDP-1 [477.387586] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.486s) [477.398521] Starting dynamic subtest: pipe-C-eDP-1 [481.740145] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.351s) [481.749478] Starting dynamic subtest: pipe-D-eDP-1 [486.091037] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.351s) [486.093442] Subtest universal-plane-functional: SUCCESS (17.136s) [486.969977] [119/133] (536s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [487.037022] Starting subtest: y-tiled-ccs-to-yf-tiled [487.041341] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [487.247297] [120/133] (536s left) kms_psr (psr2-sprite-mmap-cpu) [487.341253] Starting subtest: psr2-sprite-mmap-cpu [487.343576] Starting dynamic subtest: eDP-1 [489.034949] Dynamic subtest eDP-1: SUCCESS (1.692s) [489.037076] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.693s) [489.917656] [121/133] (533s left) kms_pm_lpsp (kms-lpsp) [491.019320] Starting subtest: kms-lpsp [491.021116] Starting dynamic subtest: pipe-A-eDP-1 [491.163145] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.147s) [491.458678] Subtest kms-lpsp: SUCCESS (0.443s) [492.363679] [122/133] (531s left) syncobj_eventfd (invalid-bad-pad) [492.418902] Starting subtest: invalid-bad-pad [492.421196] Subtest invalid-bad-pad: SUCCESS (0.000s) [492.555818] [123/133] (531s left) gem_readwrite (read-bad-handle) [492.622165] Subtest read-bad-handle: SKIP (0.000s) [492.690872] [124/133] (531s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [492.791889] Starting subtest: psr-rgb565-draw-render [499.817416] Subtest psr-rgb565-draw-render: SUCCESS (7.027s) [499.984901] [125/133] (523s left) gem_spin_batch (user-each) [500.055647] Starting subtest: user-each [503.325628] Subtest user-each: SUCCESS (3.261s) [504.010127] [126/133] (519s left) syncobj_basic (bad-destroy-pad) [504.069817] Starting subtest: bad-destroy-pad [504.072079] Subtest bad-destroy-pad: SUCCESS (0.000s) [504.196707] [127/133] (519s left) kms_addfb_basic (basic-y-tiled-legacy) [504.252525] Starting subtest: basic-y-tiled-legacy [504.256965] Subtest basic-y-tiled-legacy: SKIP (0.000s) [504.419656] [128/133] (519s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [504.507985] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [504.510289] Starting dynamic subtest: pipe-A-eDP-1 [504.518910] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [504.529393] Starting dynamic subtest: pipe-B-eDP-1 [504.539109] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [504.546703] Starting dynamic subtest: pipe-C-eDP-1 [504.555288] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [504.563096] Starting dynamic subtest: pipe-D-eDP-1 [504.571504] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [504.575626] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [506.682146] [129/133] (517s left) kms_rotation_crc (primary-rotation-180) [506.774903] Starting subtest: primary-rotation-180 [513.739657] Subtest primary-rotation-180: SUCCESS (6.966s) [514.949227] [130/133] (509s left) prime_vgem (fence-write-hang) [515.050105] Subtest fence-write-hang: SKIP (0.000s) [515.165777] [131/133] (508s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [515.264312] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [515.268625] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [515.382503] [132/133] (508s left) gem_exec_balancer (indices) [515.444259] Starting subtest: indices [517.871978] Subtest indices: SUCCESS (2.429s) [518.187845] [133/133] (505s left) prime_mmap (test_forked_cpu_write) [518.243501] Starting subtest: test_forked_cpu_write [518.245501] Starting dynamic subtest: test_forked_cpu_write-smem [518.247485] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.006s) [518.249875] Subtest test_forked_cpu_write: SUCCESS (0.007s) [518.380348] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: syncobj_wait results: parsing output: 2/ for test: gem_blits results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: kms_async_flips results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_pm_rpm results: parsing output: 7/ for test: gem_exercise_blt results: parsing output: 8/ for test: vgem_slow results: parsing output: 9/ for test: kms_content_protection results: parsing output: 10/ for test: kms_feature_discovery results: parsing output: 11/ for test: gem_mmap_gtt results: parsing output: 12/ for test: kms_cursor_legacy results: parsing output: 13/ for test: gen7_exec_parse results: parsing output: 14/ for test: gem_exec_fence results: parsing output: 15/ for test: gem_mmap_wc results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_joiner results: parsing output: 18/ for test: gem_ctx_isolation results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_cursor_crc results: parsing output: 21/ for test: gem_ctx_bad_destroy results: parsing output: 22/ for test: kms_psr results: parsing output: 23/ for test: api_intel_bb results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: gem_exec_schedule results: parsing output: 26/ for test: kms_flip results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: gem_exec_capture results: parsing output: 29/ for test: drm_read results: parsing output: 30/ for test: kms_rotation_crc results: parsing output: 31/ for test: gem_basic results: parsing output: 32/ for test: kms_plane_multiple results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: kms_flip results: parsing output: 35/ for test: kms_rotation_crc results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_ccs results: parsing output: 39/ for test: gem_mmap_gtt results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_cursor_edge_walk results: parsing output: 43/ for test: kms_cursor_legacy results: parsing output: 44/ for test: syncobj_timeline results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_exec_schedule results: parsing output: 48/ for test: kms_properties results: parsing output: 49/ for test: kms_setmode results: parsing output: 50/ for test: gem_tiled_blits results: parsing output: 51/ for test: gem_mmap_offset results: parsing output: 52/ for test: gem_spin_batch results: parsing output: 53/ for test: i915_pm_rps results: parsing output: 54/ for test: i915_fb_tiling results: parsing output: 55/ for test: prime_busy results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: perf results: parsing output: 58/ for test: gem_mmap_gtt results: parsing output: 59/ for test: kms_chamelium_hpd results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: device_reset results: parsing output: 62/ for test: gem_exec_reloc results: parsing output: 63/ for test: kms_ccs results: parsing output: 64/ for test: prime_self_import results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: gem_mmap_wc results: parsing output: 69/ for test: gem_pwrite results: parsing output: 70/ for test: i915_drm_fdinfo results: parsing output: 71/ for test: gem_exec_fence results: parsing output: 72/ for test: perf results: parsing output: 73/ for test: syncobj_timeline results: parsing output: 74/ for test: gem_exec_reloc results: parsing output: 75/ for test: kms_lease results: parsing output: 76/ for test: kms_busy results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: syncobj_basic results: parsing output: 79/ for test: gem_exec_flush results: parsing output: 80/ for test: gem_ctx_sseu results: parsing output: 81/ for test: kms_cursor_legacy results: parsing output: 82/ for test: syncobj_wait results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: kms_plane_scaling results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: gem_pxp results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: kms_color results: parsing output: 89/ for test: gem_ccs results: parsing output: 90/ for test: kms_writeback results: parsing output: 91/ for test: gem_exec_whisper results: parsing output: 92/ for test: gem_partial_pwrite_pread results: parsing output: 93/ for test: kms_vblank results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_psr2_sf results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_psr2_sf results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_invalid_mode results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: gem_ctx_persistence results: parsing output: 102/ for test: kms_flip_tiling results: parsing output: 103/ for test: kms_psr results: parsing output: 104/ for test: kms_chamelium_frames results: parsing output: 105/ for test: kms_ccs results: parsing output: 106/ for test: kms_colorop results: parsing output: 107/ for test: kms_draw_crc results: parsing output: 108/ for test: gem_exec_params results: parsing output: 109/ for test: kms_flip_scaled_crc results: parsing output: 110/ for test: kms_cursor_crc results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_plane_scaling results: parsing output: 114/ for test: kms_concurrent results: parsing output: 115/ for test: i915_pm_rpm results: parsing output: 116/ for test: syncobj_wait results: parsing output: 117/ for test: kms_universal_plane results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: kms_pm_lpsp results: parsing output: 121/ for test: syncobj_eventfd results: parsing output: 122/ for test: gem_readwrite results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_spin_batch results: parsing output: 125/ for test: syncobj_basic results: parsing output: 126/ for test: kms_addfb_basic results: parsing output: 127/ for test: kms_ccs results: parsing output: 128/ for test: kms_rotation_crc results: parsing output: 129/ for test: prime_vgem results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: gem_exec_balancer results: parsing output: 132/ for test: prime_mmap Done.