[55.119626] Initializing watchdogs [55.119737] /dev/watchdog0 [55.133923] [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] [55.138314] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.140776] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.144141] [001/133] (960s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [55.214131] Starting subtest: multi-wait-for-submit-submitted-signaled [55.216519] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [55.327891] [002/133] (960s left) syncobj_wait (wait-for-submit-snapshot) [55.381574] Starting subtest: wait-for-submit-snapshot [55.462306] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [55.549115] [003/133] (960s left) gem_blits (basic) [55.609928] Starting subtest: basic [57.720892] Subtest basic: SUCCESS (2.111s) [57.876644] [004/133] (957s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [57.988809] Starting subtest: yf-tiled-8bpp-rotate-180 [57.993138] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [58.121146] [005/133] (957s left) kms_async_flips (test-cursor) [58.225077] Starting subtest: test-cursor [58.229432] Subtest test-cursor: SKIP (0.000s) [59.423440] [006/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [59.523970] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [59.528317] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [59.645654] [007/133] (956s left) kms_pm_rpm (pm-caching) [61.189557] Starting subtest: pm-caching [61.195143] Subtest pm-caching: SKIP (0.000s) [61.996372] [008/133] (953s left) gem_exercise_blt (fast-copy-emit) [62.054967] Starting subtest: fast-copy-emit [62.057504] Starting dynamic subtest: linear-smem-smem-emit [62.076402] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [62.085410] Starting dynamic subtest: xmajor-smem-smem-emit [62.093706] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [62.101074] Starting dynamic subtest: tile4-smem-smem-emit [62.110775] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s) [62.117868] Starting dynamic subtest: tile64-smem-smem-emit [62.127831] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s) [62.130226] Subtest fast-copy-emit: SUCCESS (0.074s) [62.274841] [009/133] (953s left) vgem_slow (nohang) [62.373307] Starting subtest: nohang [72.818306] Subtest nohang: SUCCESS (10.446s) [72.892427] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true [72.895549] [010/133] (943s left) kms_content_protection (lic-type-0) [73.041863] Starting subtest: lic-type-0 [73.046680] Subtest lic-type-0: SKIP (0.000s) [73.185795] [011/133] (942s left) kms_feature_discovery (display-3x) [73.278026] Starting subtest: display-3x [73.282634] Subtest display-3x: SKIP (0.000s) [73.360313] [012/133] (942s left) gem_mmap_gtt (cpuset-medium-copy-xy) [73.405879] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [73.472583] [013/133] (942s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [73.588303] Starting subtest: cursorA-vs-flipA-varying-size [84.724822] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.136s) [85.586025] [014/133] (930s left) gen7_exec_parse (load-register-reg) [85.650768] Subtest load-register-reg: SKIP (0.000s) [85.731780] [015/133] (930s left) gem_exec_fence (syncobj-wait) [86.148709] Starting subtest: syncobj-wait [87.948927] Subtest syncobj-wait: SUCCESS (1.798s) [88.337622] [016/133] (927s left) gem_mmap_wc (write-read-distinct) [88.398497] Subtest write-read-distinct: SKIP (0.000s) [88.454667] [017/133] (927s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [88.562646] Starting subtest: psr-rgb101010-draw-mmap-wc [95.678108] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.120s) [95.805149] [018/133] (920s left) kms_joiner (basic-ultra-joiner) [95.920185] Subtest basic-ultra-joiner: SKIP (0.000s) [95.991844] [019/133] (920s left) gem_ctx_isolation (nonpriv-switch) [96.059407] Starting subtest: nonpriv-switch [96.061668] Starting dynamic subtest: rcs0 [96.351916] Dynamic subtest rcs0: SUCCESS (0.293s) [96.359551] Starting dynamic subtest: bcs0 [96.642316] Dynamic subtest bcs0: SUCCESS (0.289s) [96.652437] Starting dynamic subtest: vcs0 [96.935626] Dynamic subtest vcs0: SUCCESS (0.293s) [96.946711] Starting dynamic subtest: vcs1 [98.150228] Dynamic subtest vcs1: SUCCESS (1.214s) [98.159654] Starting dynamic subtest: vecs0 [100.221426] Dynamic subtest vecs0: SUCCESS (2.070s) [100.230842] Starting dynamic subtest: ccs0 [102.238760] Dynamic subtest ccs0: SUCCESS (2.016s) [102.241200] Subtest nonpriv-switch: SUCCESS (6.178s) [102.519712] [020/133] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [102.623109] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [109.212989] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.592s) [109.370196] [021/133] (907s left) kms_cursor_crc (cursor-sliding-128x42) [109.582607] Starting subtest: cursor-sliding-128x42 [109.634429] Subtest cursor-sliding-128x42: SKIP (0.047s) [109.859859] [022/133] (906s left) gem_ctx_bad_destroy (invalid-default-ctx) [109.917999] Starting subtest: invalid-default-ctx [109.920704] Subtest invalid-default-ctx: SUCCESS (0.000s) [110.016225] [023/133] (906s left) kms_psr (fbc-psr-suspend) [110.108084] Starting subtest: fbc-psr-suspend [110.110313] Starting dynamic subtest: eDP-1 [110.114585] Dynamic subtest eDP-1: SKIP (0.000s) [110.118685] Subtest fbc-psr-suspend: SKIP (0.001s) [110.191537] [024/133] (906s left) api_intel_bb (reset-bb) [110.237636] Starting subtest: reset-bb [110.242223] Subtest reset-bb: SUCCESS (0.005s) [110.401852] [025/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [110.501049] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [110.504529] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [110.622271] [026/133] (906s left) gem_exec_schedule (u-fairslice-all) [110.694999] Starting subtest: u-fairslice-all [112.752147] Subtest u-fairslice-all: SUCCESS (2.058s) [113.987669] [027/133] (902s left) kms_flip (flip-vs-fences) [114.096554] Starting subtest: flip-vs-fences [114.100766] Subtest flip-vs-fences: SKIP (0.000s) [114.225346] [028/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [114.333272] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [115.414350] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.082s) [115.577741] [029/133] (901s left) gem_exec_capture (capture-recoverable) [115.635365] Starting subtest: capture-recoverable [115.641537] Subtest capture-recoverable: SUCCESS (0.004s) [115.789551] [030/133] (900s left) drm_read (empty-block) [115.922336] Starting subtest: empty-block [116.923101] Subtest empty-block: SUCCESS (1.000s) [117.104272] [031/133] (899s left) kms_rotation_crc (bad-tiling) [117.201099] Starting subtest: bad-tiling [117.205646] Subtest bad-tiling: SKIP (0.001s) [117.282971] [032/133] (899s left) gem_basic (create-close) [117.343022] Starting subtest: create-close [117.347269] Subtest create-close: SUCCESS (0.000s) [117.469575] [033/133] (899s left) kms_plane_multiple (2x-tiling-4) [117.552555] Starting subtest: 2x-tiling-4 [117.556974] Subtest 2x-tiling-4: SKIP (0.000s) [117.631579] [034/133] (899s left) kms_psr (fbc-psr-cursor-mmap-cpu) [117.732306] Starting subtest: fbc-psr-cursor-mmap-cpu [117.734565] Starting dynamic subtest: eDP-1 [117.739072] Dynamic subtest eDP-1: SKIP (0.000s) [117.744248] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [117.814399] [035/133] (899s left) kms_flip (2x-blocking-absolute-wf_vblank) [117.911735] Starting subtest: 2x-blocking-absolute-wf_vblank [117.920502] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [118.008845] [036/133] (899s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [118.096077] Starting subtest: multiplane-rotation-cropping-bottom [125.288649] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.193s) [125.438901] [037/133] (891s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [125.539472] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [125.542990] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [125.662226] [038/133] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [125.767879] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [125.771257] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [125.899457] [039/133] (891s left) kms_ccs (random-ccs-data-y-tiled-ccs) [125.994535] Starting subtest: random-ccs-data-y-tiled-ccs [125.996553] Starting dynamic subtest: pipe-A-eDP-1 [126.018288] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [126.027447] Starting dynamic subtest: pipe-B-eDP-1 [126.047363] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [126.054768] Starting dynamic subtest: pipe-C-eDP-1 [126.074714] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [126.081689] Starting dynamic subtest: pipe-D-eDP-1 [126.101461] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [126.104878] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s) [128.226936] [040/133] (888s left) gem_mmap_gtt (big-copy-xy) [128.283796] Subtest big-copy-XY: SKIP (0.000s) [128.352555] [041/133] (888s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [128.456802] Starting subtest: fbcpsr-farfromfence-mmap-gtt [128.461228] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [128.601717] [042/133] (888s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [128.700102] Starting subtest: fbc-rgb565-draw-pwrite [133.340742] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.643s) [134.547172] [043/133] (882s left) kms_cursor_edge_walk (256x256-top-bottom) [134.649657] Starting subtest: 256x256-top-bottom [134.652083] Starting dynamic subtest: pipe-A-eDP-1 [138.077132] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s) [138.086499] Starting dynamic subtest: pipe-D-eDP-1 [141.209402] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s) [141.211613] Subtest 256x256-top-bottom: SUCCESS (6.563s) [142.029434] [044/133] (875s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [142.144316] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [159.614453] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.470s) [160.511889] [045/133] (856s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [160.572509] Starting subtest: multi-wait-for-submit-available-submitted-signaled [160.574931] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [160.704928] [046/133] (856s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [160.800793] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [160.803110] Starting dynamic subtest: pipe-A-eDP-1 [160.825775] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [160.834985] Starting dynamic subtest: pipe-B-eDP-1 [160.856997] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [160.864414] Starting dynamic subtest: pipe-C-eDP-1 [160.886212] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [160.893589] Starting dynamic subtest: pipe-D-eDP-1 [160.915577] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [160.919849] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [162.965497] [047/133] (854s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [163.070873] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [166.707464] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.641s) [167.874574] [048/133] (849s left) gem_exec_schedule (pi-distinct-iova) [168.056920] Starting subtest: pi-distinct-iova [168.059297] Starting dynamic subtest: rcs0 [168.130162] Dynamic subtest rcs0: SUCCESS (0.074s) [168.143145] Starting dynamic subtest: vcs0 [168.196302] Dynamic subtest vcs0: SUCCESS (0.066s) [168.204404] Starting dynamic subtest: vcs1 [168.256229] Dynamic subtest vcs1: SUCCESS (0.059s) [168.265764] Starting dynamic subtest: vecs0 [168.309871] Dynamic subtest vecs0: SUCCESS (0.052s) [168.318864] Starting dynamic subtest: ccs0 [168.370654] Dynamic subtest ccs0: SUCCESS (0.059s) [168.373173] Subtest pi-distinct-iova: SUCCESS (0.316s) [170.035627] [049/133] (847s left) kms_properties (colorop-properties-atomic) [170.134323] Starting subtest: colorop-properties-atomic [170.136639] Starting dynamic subtest: pipe-A-eDP-1 [170.493069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s) [170.503209] Starting dynamic subtest: pipe-B-eDP-1 [171.501765] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.008s) [171.510729] Starting dynamic subtest: pipe-C-eDP-1 [172.521775] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.020s) [172.531328] Starting dynamic subtest: pipe-D-eDP-1 [173.563402] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.038s) [173.565621] Subtest colorop-properties-atomic: SUCCESS (3.430s) [174.384598] [050/133] (843s left) kms_setmode (invalid-clone-single-crtc) [174.431521] Starting subtest: invalid-clone-single-crtc [174.438222] Subtest invalid-clone-single-crtc: SKIP (0.000s) [174.564502] [051/133] (843s left) gem_tiled_blits (interruptible) [174.621264] Subtest interruptible: SKIP (0.000s) [174.712568] [052/133] (842s left) gem_mmap_offset (basic-uaf) [174.770630] Starting subtest: basic-uaf [174.773047] Subtest basic-uaf: SUCCESS (0.002s) [174.898365] [053/133] (842s left) gem_spin_batch (engines) [174.954245] Starting subtest: engines [174.956494] Starting dynamic subtest: rcs0 [178.189140] Dynamic subtest rcs0: SUCCESS (3.233s) [178.199465] Starting dynamic subtest: bcs0 [181.424140] Dynamic subtest bcs0: SUCCESS (3.233s) [181.437415] Starting dynamic subtest: vcs0 [184.659523] Dynamic subtest vcs0: SUCCESS (3.233s) [184.667857] Starting dynamic subtest: vcs1 [187.897504] Dynamic subtest vcs1: SUCCESS (3.235s) [187.905416] Starting dynamic subtest: vecs0 [191.133769] Dynamic subtest vecs0: SUCCESS (3.234s) [191.144049] Starting dynamic subtest: ccs0 [194.371589] Dynamic subtest ccs0: SUCCESS (3.235s) [194.373644] Subtest engines: SUCCESS (19.419s) [194.636630] [054/133] (823s left) i915_pm_rps (thresholds-park) [194.703027] Starting subtest: thresholds-park [194.707819] Subtest thresholds-park: SKIP (0.001s) [194.792115] [055/133] (822s left) i915_fb_tiling (basic-x-tiling) [194.836066] Subtest basic-x-tiling: SKIP (0.000s) [194.896681] [056/133] (822s left) prime_busy (hang-wait) [194.950236] Starting subtest: hang-wait [194.952570] Starting dynamic subtest: rcs0 [221.365940] Dynamic subtest rcs0: SUCCESS (26.413s) [221.375670] Starting dynamic subtest: bcs0 [228.517619] Dynamic subtest bcs0: SUCCESS (7.152s) [228.526839] Starting dynamic subtest: vcs0 [235.494729] Dynamic subtest vcs0: SUCCESS (6.975s) [235.502758] Starting dynamic subtest: vcs1 [242.538654] Dynamic subtest vcs1: SUCCESS (7.042s) [242.548505] Starting dynamic subtest: vecs0 [249.567058] Dynamic subtest vecs0: SUCCESS (7.031s) [249.577807] Starting dynamic subtest: ccs0 [263.343396] Dynamic subtest ccs0: SUCCESS (13.772s) [263.346045] Subtest hang-wait: SUCCESS (68.395s) [263.505479] [057/133] (754s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [263.618600] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [263.622825] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [263.746204] [058/133] (754s left) perf (non-zero-reason) [263.879821] Starting subtest: non-zero-reason [263.882174] Starting dynamic subtest: 0-rcs0 [269.258072] Dynamic subtest 0-rcs0: SUCCESS (5.377s) [269.270473] Starting dynamic subtest: 1-vcs0 [273.187555] Dynamic subtest 1-vcs0: SUCCESS (3.929s) [273.190766] Subtest non-zero-reason: SUCCESS (9.308s) [273.229736] [059/133] (744s left) gem_mmap_gtt (basic-small-copy-xy) [273.286180] Subtest basic-small-copy-XY: SKIP (0.000s) [273.355382] [060/133] (744s left) kms_chamelium_hpd (vga-hpd-fast) [273.743970] Subtest vga-hpd-fast: SKIP (0.000s) [274.553256] [061/133] (743s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [274.661317] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [275.695594] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.034s) [275.841989] [062/133] (742s left) device_reset (unbind-cold-reset-rebind) [275.888931] Starting subtest: unbind-cold-reset-rebind [275.892802] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [275.969097] [063/133] (742s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [276.030334] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [276.090646] [064/133] (742s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [276.182501] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [276.184532] Starting dynamic subtest: pipe-A-eDP-1 [276.469687] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.260s) [276.477828] Starting dynamic subtest: pipe-B-eDP-1 [277.769326] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.293s) [277.779698] Starting dynamic subtest: pipe-C-eDP-1 [279.041355] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.272s) [279.049694] Starting dynamic subtest: pipe-D-eDP-1 [280.277299] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s) [280.279353] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.063s) [281.508080] [065/133] (736s left) prime_self_import (basic-with_one_bo) [281.544298] Starting subtest: basic-with_one_bo [281.573560] Subtest basic-with_one_bo: SUCCESS (0.031s) [281.725179] [066/133] (736s left) kms_big_fb (4-tiled-64bpp-rotate-180) [281.833293] Starting subtest: 4-tiled-64bpp-rotate-180 [283.434638] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.601s) [283.634693] [067/133] (734s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [283.688725] Starting subtest: etime-multi-wait-all-for-submit-submitted [283.794317] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s) [283.883872] [068/133] (734s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [283.974452] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [283.976790] Starting dynamic subtest: A-eDP1 [287.535452] Dynamic subtest A-eDP1: SUCCESS (3.557s) [287.543845] Starting dynamic subtest: B-eDP1 [290.714853] Dynamic subtest B-eDP1: SUCCESS (3.177s) [290.723454] Starting dynamic subtest: C-eDP1 [293.821935] Dynamic subtest C-eDP1: SUCCESS (3.106s) [293.830309] Starting dynamic subtest: D-eDP1 [296.917593] Dynamic subtest D-eDP1: SUCCESS (3.095s) [296.919510] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.942s) [297.745247] [069/133] (720s left) gem_mmap_wc (invalid-flags) [297.801104] Subtest invalid-flags: SKIP (0.000s) [297.869440] [070/133] (720s left) gem_pwrite (basic-self) [297.924419] Subtest basic-self: SKIP (0.000s) [297.984228] [071/133] (720s left) i915_drm_fdinfo (most-busy-check-all) [298.021889] Starting subtest: most-busy-check-all [298.024228] Starting dynamic subtest: rcs0 [298.028787] Dynamic subtest rcs0: SKIP (0.004s) [298.038744] Starting dynamic subtest: bcs0 [298.043138] Dynamic subtest bcs0: SKIP (0.000s) [298.051191] Starting dynamic subtest: vcs0 [298.055340] Dynamic subtest vcs0: SKIP (0.000s) [298.063285] Starting dynamic subtest: vcs1 [298.067639] Dynamic subtest vcs1: SKIP (0.000s) [298.075403] Starting dynamic subtest: vecs0 [298.079773] Dynamic subtest vecs0: SKIP (0.000s) [298.087636] Starting dynamic subtest: ccs0 [298.092027] Dynamic subtest ccs0: SKIP (0.000s) [298.096409] Subtest most-busy-check-all: SKIP (0.010s) [298.133248] [072/133] (720s left) gem_exec_fence (parallel) [298.328284] Starting subtest: parallel [298.330368] Starting dynamic subtest: rcs0 [300.477770] Dynamic subtest rcs0: SUCCESS (2.153s) [300.487581] Starting dynamic subtest: bcs0 [302.631213] Dynamic subtest bcs0: SUCCESS (2.153s) [302.640717] Starting dynamic subtest: vcs0 [304.781467] Dynamic subtest vcs0: SUCCESS (2.149s) [304.790748] Starting dynamic subtest: vcs1 [306.935343] Dynamic subtest vcs1: SUCCESS (2.153s) [306.945663] Starting dynamic subtest: vecs0 [309.085545] Dynamic subtest vecs0: SUCCESS (2.150s) [309.093637] Starting dynamic subtest: ccs0 [311.238453] Dynamic subtest ccs0: SUCCESS (2.152s) [311.240272] Subtest parallel: SUCCESS (12.914s) [312.008184] [073/133] (706s left) perf (unprivileged-single-ctx-counters) [312.102195] Starting subtest: unprivileged-single-ctx-counters [312.107070] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [312.145396] [074/133] (706s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [312.196694] Starting subtest: etime-single-wait-available-unsubmitted [312.305522] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s) [312.396556] [075/133] (706s left) gem_exec_reloc (basic-wc-gtt-noreloc) [312.464663] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [312.522091] [076/133] (706s left) kms_lease (possible-crtcs-filtering) [312.620174] Starting subtest: possible-crtcs-filtering [312.625310] Subtest possible-crtcs-filtering: SUCCESS (0.006s) [312.740657] [077/133] (705s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [312.827459] Starting subtest: extended-pageflip-modeset-hang-oldfb [312.829713] Starting dynamic subtest: pipe-A [320.727095] Dynamic subtest pipe-A: SUCCESS (7.899s) [320.738229] Starting dynamic subtest: pipe-D [329.326786] Dynamic subtest pipe-D: SUCCESS (8.594s) [329.329222] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.498s) [330.187126] [078/133] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [330.298093] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [330.302309] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [330.426265] [079/133] (688s left) syncobj_basic (bad-pad-handle-to-fd) [330.488533] Starting subtest: bad-pad-handle-to-fd [330.490979] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [330.594392] [080/133] (688s left) gem_exec_flush (basic-wb-pro-default) [330.657073] Starting subtest: basic-wb-pro-default [336.113443] Subtest basic-wb-pro-default: SUCCESS (5.457s) [336.311423] [081/133] (682s left) gem_ctx_sseu (mmap-args) [336.366962] Subtest mmap-args: SKIP (0.000s) [336.453554] [082/133] (682s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [336.573563] Starting subtest: nonblocking-modeset-vs-cursor-atomic [337.955588] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.381s) [338.761549] [083/133] (680s left) syncobj_wait (invalid-signal-one-illegal-handle) [338.822314] Starting subtest: invalid-signal-one-illegal-handle [338.824718] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [338.927536] [084/133] (680s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [339.036461] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [339.671728] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s) [339.868631] [085/133] (679s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [339.959919] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [339.962260] Starting dynamic subtest: pipe-A [340.071487] Dynamic subtest pipe-A: SKIP (0.109s) [340.081961] Starting dynamic subtest: pipe-B [341.227021] Dynamic subtest pipe-B: SKIP (1.155s) [341.236100] Starting dynamic subtest: pipe-C [342.446370] Dynamic subtest pipe-C: SUCCESS (1.223s) [342.455340] Starting dynamic subtest: pipe-D [343.667654] Dynamic subtest pipe-D: SUCCESS (1.221s) [343.670078] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.710s) [344.863917] [086/133] (674s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [344.955991] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [352.400641] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.448s) [352.572187] [087/133] (666s left) gem_pxp (reject-modify-context-protection-off-3) [352.700671] Starting subtest: reject-modify-context-protection-off-3 [352.703306] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s) [352.844735] [088/133] (666s left) syncobj_timeline (wait-all-for-submit-snapshot) [352.903430] Starting subtest: wait-all-for-submit-snapshot [352.986280] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [353.085659] [089/133] (666s left) kms_color (ctm-signed) [353.180404] Starting subtest: ctm-signed [353.182628] Starting dynamic subtest: pipe-A-eDP-1 [355.278936] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s) [355.288058] Starting dynamic subtest: pipe-B-eDP-1 [358.131448] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.850s) [358.142311] Starting dynamic subtest: pipe-C-eDP-1 [360.745704] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s) [360.759768] Starting dynamic subtest: pipe-D-eDP-1 [363.429088] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.682s) [363.431459] Subtest ctm-signed: SUCCESS (10.251s) [364.249706] [090/133] (654s left) gem_ccs (suspend-resume) [364.314875] Starting subtest: suspend-resume [364.319492] Subtest suspend-resume: SKIP (0.000s) [364.436385] [091/133] (654s left) kms_writeback (writeback-check-output) [364.530809] Subtest writeback-check-output: SKIP (0.000s) [364.579626] [092/133] (654s left) gem_exec_whisper (basic-normal-all) [364.647891] Starting subtest: basic-normal-all [366.918731] Subtest basic-normal-all: SUCCESS (2.271s) [367.117171] [093/133] (652s left) gem_partial_pwrite_pread (write-snoop) [367.187896] Subtest write-snoop: SKIP (0.000s) [367.266775] [094/133] (652s left) kms_vblank (ts-continuation-modeset-rpm) [367.354251] Starting subtest: ts-continuation-modeset-rpm [367.356467] Starting dynamic subtest: pipe-A-eDP-1 [369.936649] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.579s) [369.950421] Starting dynamic subtest: pipe-D-eDP-1 [372.153060] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.215s) [372.155511] Subtest ts-continuation-modeset-rpm: SUCCESS (4.797s) [372.965419] [095/133] (646s left) kms_frontbuffer_tracking (fbc-stridechange) [373.061086] Starting subtest: fbc-stridechange [376.405871] Subtest fbc-stridechange: SUCCESS (3.348s) [377.573488] [096/133] (641s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [382.647198] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [382.649563] Starting dynamic subtest: pipe-A-eDP-1 [383.435545] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s) [383.444765] Starting dynamic subtest: pipe-B-eDP-1 [384.572400] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s) [384.576802] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.925s) [385.777124] [097/133] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [385.885697] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [385.890054] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [385.997159] [098/133] (633s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [391.037993] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [391.040371] Starting dynamic subtest: pipe-A-eDP-1 [397.649696] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.611s) [397.658701] Starting dynamic subtest: pipe-B-eDP-1 [404.315413] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.663s) [404.317856] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.279s) [405.193589] [099/133] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [405.295854] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [405.300032] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [405.402529] [100/133] (614s left) kms_invalid_mode (bad-vsync-end) [405.490596] Starting subtest: bad-vsync-end [405.492843] Starting dynamic subtest: pipe-A-eDP-1 [405.782709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [405.791854] Starting dynamic subtest: pipe-B-eDP-1 [405.794066] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [405.802245] Starting dynamic subtest: pipe-C-eDP-1 [405.804430] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [405.812592] Starting dynamic subtest: pipe-D-eDP-1 [405.814509] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [405.816436] Subtest bad-vsync-end: SUCCESS (0.299s) [406.619231] [101/133] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [406.719869] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [406.724363] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [406.848371] [102/133] (612s left) gem_ctx_persistence (heartbeat-hang) [406.908615] Starting subtest: heartbeat-hang [406.914309] Subtest heartbeat-hang: SKIP (0.000s) [407.040396] [103/133] (612s left) kms_flip_tiling (flip-change-tiling) [407.135837] Starting subtest: flip-change-tiling [407.138156] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [407.310714] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.175s) [407.322781] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [407.445355] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [407.457710] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [407.578566] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [407.589944] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [407.721659] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [407.733479] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [407.865820] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [407.877234] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [408.011379] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s) [408.022907] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [408.154433] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s) [408.167829] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [408.277275] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s) [408.289066] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [408.422820] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [408.434218] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [408.594874] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.169s) [408.605080] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [408.737714] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [408.749724] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [408.882323] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [408.896206] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [409.016211] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [409.027320] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [409.150324] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [409.161585] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [409.260791] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [409.271862] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [409.433373] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s) [409.443220] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [409.576593] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [409.588277] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [409.720512] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [409.731749] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [409.865999] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [409.877831] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [410.010228] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [410.022242] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [410.154726] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [410.167036] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [410.277809] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s) [410.287762] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [410.420464] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s) [410.432085] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [410.564795] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [410.578543] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [410.709255] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [410.721110] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [410.853578] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [410.867444] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [410.998154] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [411.011627] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [411.142632] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s) [411.156441] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [411.265499] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s) [411.279956] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [411.421083] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.154s) [411.433436] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [411.564901] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [411.577843] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [411.709098] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [411.722808] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [411.854335] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [411.865473] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [411.998174] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s) [412.009935] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [412.143634] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s) [412.154856] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [412.265481] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s) [412.317472] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [413.569080] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.258s) [413.579098] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [413.703318] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [413.715580] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [413.848044] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [413.859628] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [413.991473] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [414.002507] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [414.135475] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [414.153327] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [414.279839] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [414.291704] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [414.424777] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s) [414.436813] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [414.536345] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [414.548155] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [414.670407] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [414.682235] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [414.814189] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [414.826386] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [414.958043] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [414.970673] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [415.113282] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.153s) [415.124319] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [415.246379] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [415.258228] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [415.381719] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [415.393222] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [415.491510] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [415.501674] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [415.624967] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.131s) [415.634913] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [415.768750] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [415.780833] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [415.913325] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [415.924923] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [416.057899] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [416.069441] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [416.203074] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [416.214925] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [416.347059] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [416.357097] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [416.479847] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.131s) [416.493481] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [416.635053] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.153s) [416.646908] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [416.779591] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s) [416.793341] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [416.923675] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [416.937422] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [417.068436] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [417.084348] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [417.212828] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [417.227099] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [417.384919] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.169s) [417.399367] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [417.507484] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.119s) [417.519059] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [417.652193] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [417.663711] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [417.795655] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [417.809288] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [417.940134] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [417.953076] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [418.084982] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [418.096377] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [418.229727] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s) [418.241673] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [418.373978] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s) [418.388069] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [418.496291] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s) [418.548995] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [419.795048] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.253s) [419.805954] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [419.895104] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.097s) [419.905256] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [420.006576] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.110s) [420.018732] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [420.117382] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [420.127160] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [420.227974] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [420.241086] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [420.338813] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [420.353733] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [420.438964] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [420.450060] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [420.539629] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [420.551110] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [420.639588] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [420.649959] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [420.749832] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s) [420.762173] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [420.860919] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [420.872603] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [420.960691] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.099s) [420.971874] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [421.060795] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s) [421.074172] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [421.172590] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.108s) [421.183894] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [421.283583] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [421.295211] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [421.394542] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [421.406327] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [421.505360] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [421.515774] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [421.616457] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [421.627213] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [421.728091] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s) [421.737412] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [421.839736] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [421.851407] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [421.949905] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [421.960091] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [422.061150] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.110s) [422.074867] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [422.172025] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.108s) [422.181787] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [422.283102] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s) [422.295242] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [422.394495] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.108s) [422.405522] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [422.505057] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [422.513994] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [422.616478] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [422.627617] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [422.727924] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s) [422.742839] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [422.839378] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s) [422.850811] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [422.950036] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s) [422.961200] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [423.060939] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [423.072509] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [423.171970] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [423.183974] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [423.283053] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [423.293762] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [423.393949] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s) [423.407783] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [423.505462] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s) [423.515261] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [423.616591] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s) [423.658070] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [424.918713] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.267s) [424.930550] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [425.018238] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [425.028878] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [425.118333] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [425.129602] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [425.229608] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [425.241792] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [425.339896] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [425.349608] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [425.451285] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s) [425.460495] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [425.551603] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.097s) [425.563197] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [425.662621] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [425.672252] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [425.762508] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [425.774049] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [425.873326] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [425.883640] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [425.984184] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [425.994784] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [426.095307] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [426.105373] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [426.195621] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [426.206527] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [426.295871] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [426.307072] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [426.395614] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [426.406142] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [426.506849] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s) [426.518825] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [426.617485] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.108s) [426.628140] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [426.728726] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [426.740265] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [426.828475] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s) [426.839964] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [426.940621] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [426.951868] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [427.051927] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [427.064570] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [427.162546] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [427.171709] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [427.273073] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [427.284170] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [427.384068] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s) [427.392789] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [427.495541] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s) [427.509598] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [427.606466] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.108s) [427.616424] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [427.717469] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [427.727502] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [427.828428] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s) [427.839680] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [427.940272] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s) [427.954558] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [428.051415] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s) [428.062783] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [428.162026] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [428.173401] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [428.273128] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [428.285105] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [428.384432] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [428.399047] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [428.495127] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s) [428.505818] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [428.606727] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s) [428.618435] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [428.718089] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [428.750787] Subtest flip-change-tiling: SUCCESS (21.618s) [429.935383] [104/133] (589s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [430.035264] Starting subtest: fbc-psr2-cursor-mmap-cpu [430.037603] Starting dynamic subtest: eDP-1 [430.041833] Dynamic subtest eDP-1: SKIP (0.000s) [430.046121] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [430.136730] [105/133] (589s left) kms_chamelium_frames (dp-crc-fast) [430.507949] Subtest dp-crc-fast: SKIP (0.000s) [431.332419] [106/133] (588s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [431.426848] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [431.429379] Starting dynamic subtest: pipe-A-eDP-1 [431.450878] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [431.462124] Starting dynamic subtest: pipe-B-eDP-1 [431.482833] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s) [431.492233] Starting dynamic subtest: pipe-C-eDP-1 [431.512407] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s) [431.521574] Starting dynamic subtest: pipe-D-eDP-1 [431.543153] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s) [431.545507] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s) [433.738228] [107/133] (586s left) kms_colorop (plane-xr24-xr24-srgb_inv_eotf_lut) [433.871416] Subtest plane-XR24-XR24-srgb_inv_eotf_lut: SKIP (0.000s) [433.968459] [108/133] (585s left) kms_draw_crc (draw-method-pwrite) [434.066835] Starting subtest: draw-method-pwrite [434.069214] Starting dynamic subtest: xrgb8888-untiled [434.666111] Dynamic subtest xrgb8888-untiled: SUCCESS (0.601s) [434.675869] Starting dynamic subtest: rgb565-untiled [435.110460] Dynamic subtest rgb565-untiled: SUCCESS (0.444s) [435.119752] Starting dynamic subtest: xrgb2101010-untiled [435.654638] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.543s) [435.665814] Starting dynamic subtest: xbgr16161616f-untiled [436.421649] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.766s) [436.430892] Starting dynamic subtest: xrgb8888-xtiled [438.232448] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.810s) [438.241904] Starting dynamic subtest: rgb565-xtiled [439.332979] Dynamic subtest rgb565-xtiled: SUCCESS (1.099s) [439.350446] Starting dynamic subtest: xrgb2101010-xtiled [441.121582] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.788s) [441.130781] Starting dynamic subtest: xbgr16161616f-xtiled [444.388320] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.266s) [444.397584] Starting dynamic subtest: xrgb8888-4tiled [445.499466] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.110s) [445.508682] Starting dynamic subtest: rgb565-4tiled [446.076987] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s) [446.085936] Starting dynamic subtest: xrgb2101010-4tiled [447.176808] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.099s) [447.185925] Starting dynamic subtest: xbgr16161616f-4tiled [450.143736] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.966s) [450.146093] Subtest draw-method-pwrite: SUCCESS (16.079s) [450.281883] [109/133] (569s left) gem_exec_params (dr4-dirt) [450.339214] Starting subtest: DR4-dirt [450.341436] Subtest DR4-dirt: SUCCESS (0.000s) [450.460131] [110/133] (569s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [450.553149] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [450.555415] Starting dynamic subtest: pipe-A-default-mode [450.842097] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [450.846785] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.287s) [451.677505] [111/133] (568s left) kms_cursor_crc (cursor-random-64x21) [451.868059] Starting subtest: cursor-random-64x21 [451.920157] Subtest cursor-random-64x21: SKIP (0.045s) [452.182113] [112/133] (567s left) kms_big_fb (y-tiled-64bpp-rotate-270) [452.274347] Starting subtest: y-tiled-64bpp-rotate-270 [452.278753] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [452.380995] [113/133] (567s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [452.490039] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [459.819405] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.333s) [459.989840] [114/133] (560s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [460.098118] Starting subtest: plane-downscale-factor-0-5-with-rotation [460.100407] Starting dynamic subtest: pipe-A [460.118634] Dynamic subtest pipe-A: SKIP (0.017s) [460.130162] Starting dynamic subtest: pipe-B [460.153876] Dynamic subtest pipe-B: SKIP (0.032s) [460.166185] Starting dynamic subtest: pipe-C [460.184561] Dynamic subtest pipe-C: SKIP (0.032s) [460.197241] Starting dynamic subtest: pipe-D [460.214691] Dynamic subtest pipe-D: SKIP (0.031s) [460.218956] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.115s) [460.338655] [115/133] (559s left) kms_concurrent (multi-plane-atomic-lowres) [460.430800] Starting subtest: multi-plane-atomic-lowres [460.433128] Starting dynamic subtest: pipe-A-eDP-1 [460.919656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.488s) [460.922115] Subtest multi-plane-atomic-lowres: SUCCESS (0.489s) [461.729495] [116/133] (558s left) i915_pm_rpm (sysfs-read) [463.256767] Starting subtest: sysfs-read [464.410038] Subtest sysfs-read: SUCCESS (1.154s) [464.789515] [117/133] (555s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [464.853589] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [464.855994] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [464.989491] [118/133] (555s left) kms_universal_plane (universal-plane-functional) [465.084445] Starting subtest: universal-plane-functional [465.086791] Starting dynamic subtest: pipe-A-eDP-1 [469.030839] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.946s) [469.040518] Starting dynamic subtest: pipe-B-eDP-1 [473.721789] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.686s) [473.731771] Starting dynamic subtest: pipe-C-eDP-1 [478.094793] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.373s) [478.104100] Starting dynamic subtest: pipe-D-eDP-1 [482.486639] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.389s) [482.489062] Subtest universal-plane-functional: SUCCESS (17.402s) [483.342235] [119/133] (537s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [483.417459] Starting subtest: y-tiled-ccs-to-yf-tiled [483.421918] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [483.611499] [120/133] (536s left) kms_psr (psr2-sprite-mmap-cpu) [483.701041] Starting subtest: psr2-sprite-mmap-cpu [483.703304] Starting dynamic subtest: eDP-1 [485.407701] Dynamic subtest eDP-1: SUCCESS (1.707s) [485.409910] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.708s) [486.291790] [121/133] (534s left) kms_pm_lpsp (kms-lpsp) [487.393399] Starting subtest: kms-lpsp [487.395675] Starting dynamic subtest: pipe-A-eDP-1 [487.540348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s) [487.834646] Subtest kms-lpsp: SUCCESS (0.445s) [488.721246] [122/133] (531s left) syncobj_eventfd (invalid-bad-pad) [488.774748] Starting subtest: invalid-bad-pad [488.777133] Subtest invalid-bad-pad: SUCCESS (0.000s) [488.899607] [123/133] (531s left) gem_readwrite (read-bad-handle) [488.954842] Subtest read-bad-handle: SKIP (0.000s) [489.017067] [124/133] (531s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [489.107695] Starting subtest: psr-rgb565-draw-render [496.168257] Subtest psr-rgb565-draw-render: SUCCESS (7.063s) [496.338511] [125/133] (524s left) gem_spin_batch (user-each) [496.400927] Starting subtest: user-each [499.757236] Subtest user-each: SUCCESS (3.356s) [500.053664] [126/133] (520s left) syncobj_basic (bad-destroy-pad) [500.108220] Starting subtest: bad-destroy-pad [500.110561] Subtest bad-destroy-pad: SUCCESS (0.000s) [500.226943] [127/133] (520s left) kms_addfb_basic (basic-y-tiled-legacy) [500.278758] Starting subtest: basic-y-tiled-legacy [500.283238] Subtest basic-y-tiled-legacy: SKIP (0.000s) [500.453715] [128/133] (520s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [500.544159] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [500.546509] Starting dynamic subtest: pipe-A-eDP-1 [500.555806] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [500.566187] Starting dynamic subtest: pipe-B-eDP-1 [500.575717] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [500.586239] Starting dynamic subtest: pipe-C-eDP-1 [500.594892] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [500.603085] Starting dynamic subtest: pipe-D-eDP-1 [500.611637] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [500.615779] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [502.740018] [129/133] (518s left) kms_rotation_crc (primary-rotation-180) [502.832460] Starting subtest: primary-rotation-180 [509.732555] Subtest primary-rotation-180: SUCCESS (6.901s) [510.897019] [130/133] (509s left) prime_vgem (fence-write-hang) [510.971189] Subtest fence-write-hang: SKIP (0.000s) [511.073888] [131/133] (509s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [511.174452] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [511.178473] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [511.298130] [132/133] (509s left) gem_exec_balancer (indices) [511.357990] Starting subtest: indices [513.906988] Subtest indices: SUCCESS (2.550s) [514.211984] [133/133] (506s left) prime_mmap (test_forked_cpu_write) [514.273178] Starting subtest: test_forked_cpu_write [514.275093] Starting dynamic subtest: test_forked_cpu_write-smem [514.280168] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s) [514.282454] Subtest test_forked_cpu_write: SUCCESS (0.010s) [514.385826] 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.