[100.987960] Initializing watchdogs [100.988138] /dev/watchdog0 [101.005023] [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] [101.009535] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [101.011982] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [101.015236] [001/133] (960s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [101.092454] Starting subtest: multi-wait-for-submit-submitted-signaled [101.094779] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [101.194362] [002/133] (960s left) syncobj_wait (wait-for-submit-snapshot) [101.255078] Starting subtest: wait-for-submit-snapshot [101.336060] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [101.422715] [003/133] (960s left) gem_blits (basic) [101.475057] Starting subtest: basic [103.492089] Subtest basic: SUCCESS (2.016s) [103.633620] [004/133] (957s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [103.739366] Starting subtest: yf-tiled-8bpp-rotate-180 [103.743630] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [103.874246] [005/133] (957s left) kms_async_flips (test-cursor) [103.970068] Starting subtest: test-cursor [103.974230] Subtest test-cursor: SKIP (0.000s) [105.160514] [006/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [105.268164] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [105.272168] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [105.375296] [007/133] (956s left) kms_pm_rpm (pm-caching) [107.036014] Starting subtest: pm-caching [107.041062] Subtest pm-caching: SKIP (0.000s) [107.689700] [008/133] (954s left) gem_exercise_blt (fast-copy-emit) [107.752420] Starting subtest: fast-copy-emit [107.754801] Starting dynamic subtest: linear-smem-smem-emit [107.774911] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [107.784489] Starting dynamic subtest: xmajor-smem-smem-emit [107.791353] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [107.798497] Starting dynamic subtest: tile4-smem-smem-emit [107.808386] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s) [107.815369] Starting dynamic subtest: tile64-smem-smem-emit [107.825081] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s) [107.827446] Subtest fast-copy-emit: SUCCESS (0.073s) [107.993183] [009/133] (953s left) vgem_slow (nohang) [108.093875] Starting subtest: nohang [118.386790] Subtest nohang: SUCCESS (10.291s) [118.471853] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true [118.474896] [010/133] (943s left) kms_content_protection (lic-type-0) [118.614906] Starting subtest: lic-type-0 [118.619670] Subtest lic-type-0: SKIP (0.000s) [118.780682] [011/133] (943s left) kms_feature_discovery (display-3x) [118.880361] Starting subtest: display-3x [118.884418] Subtest display-3x: SKIP (0.000s) [118.963964] [012/133] (942s left) gem_mmap_gtt (cpuset-medium-copy-xy) [119.020850] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [119.087853] [013/133] (942s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [119.210071] Starting subtest: cursorA-vs-flipA-varying-size [130.374450] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.162s) [131.247568] [014/133] (930s left) gen7_exec_parse (load-register-reg) [131.311234] Subtest load-register-reg: SKIP (0.000s) [131.385391] [015/133] (930s left) gem_exec_fence (syncobj-wait) [131.799215] Starting subtest: syncobj-wait [132.896375] Subtest syncobj-wait: SUCCESS (1.096s) [133.270806] [016/133] (928s left) gem_mmap_wc (write-read-distinct) [133.332228] Subtest write-read-distinct: SKIP (0.000s) [133.398364] [017/133] (928s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [133.504077] Starting subtest: psr-rgb101010-draw-mmap-wc [140.638996] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.136s) [140.786595] [018/133] (921s left) kms_joiner (basic-ultra-joiner) [140.905578] Subtest basic-ultra-joiner: SKIP (0.000s) [140.990198] [019/133] (921s left) gem_ctx_isolation (nonpriv-switch) [141.061625] Starting subtest: nonpriv-switch [141.064070] Starting dynamic subtest: rcs0 [141.354616] Dynamic subtest rcs0: SUCCESS (0.293s) [141.365715] Starting dynamic subtest: bcs0 [141.642708] Dynamic subtest bcs0: SUCCESS (0.290s) [141.653157] Starting dynamic subtest: vcs0 [141.949127] Dynamic subtest vcs0: SUCCESS (0.306s) [141.958468] Starting dynamic subtest: vcs1 [143.196916] Dynamic subtest vcs1: SUCCESS (1.247s) [143.207116] Starting dynamic subtest: vecs0 [145.238095] Dynamic subtest vecs0: SUCCESS (2.040s) [145.248478] Starting dynamic subtest: ccs0 [147.266363] Dynamic subtest ccs0: SUCCESS (2.027s) [147.268679] Subtest nonpriv-switch: SUCCESS (6.207s) [147.523164] [020/133] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [147.624761] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [154.323301] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.698s) [154.492061] [021/133] (907s left) kms_cursor_crc (cursor-sliding-128x42) [154.708762] Starting subtest: cursor-sliding-128x42 [154.761477] Subtest cursor-sliding-128x42: SKIP (0.049s) [154.979246] [022/133] (907s left) gem_ctx_bad_destroy (invalid-default-ctx) [155.033686] Starting subtest: invalid-default-ctx [155.036075] Subtest invalid-default-ctx: SUCCESS (0.000s) [155.133986] [023/133] (907s left) kms_psr (fbc-psr-suspend) [155.235960] Starting subtest: fbc-psr-suspend [155.238303] Starting dynamic subtest: eDP-1 [155.242335] Dynamic subtest eDP-1: SKIP (0.000s) [155.246464] Subtest fbc-psr-suspend: SKIP (0.001s) [155.331169] [024/133] (907s left) api_intel_bb (reset-bb) [155.393161] Starting subtest: reset-bb [155.397089] Subtest reset-bb: SUCCESS (0.004s) [155.546270] [025/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [155.647061] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [155.650361] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [155.774217] [026/133] (906s left) gem_exec_schedule (u-fairslice-all) [155.837957] Starting subtest: u-fairslice-all [157.898403] Subtest u-fairslice-all: SUCCESS (2.056s) [159.952788] [027/133] (902s left) kms_flip (flip-vs-fences) [160.049319] Starting subtest: flip-vs-fences [160.054361] Subtest flip-vs-fences: SKIP (0.000s) [160.180268] [028/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [160.290441] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [161.269699] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.978s) [161.425287] [029/133] (901s left) gem_exec_capture (capture-recoverable) [161.487328] Starting subtest: capture-recoverable [161.492082] Subtest capture-recoverable: SUCCESS (0.003s) [161.629241] [030/133] (901s left) drm_read (empty-block) [161.771747] Starting subtest: empty-block [162.772766] Subtest empty-block: SUCCESS (1.000s) [162.940443] [031/133] (899s left) kms_rotation_crc (bad-tiling) [163.036325] Starting subtest: bad-tiling [163.040507] Subtest bad-tiling: SKIP (0.001s) [163.134273] [032/133] (899s left) gem_basic (create-close) [163.194969] Starting subtest: create-close [163.199313] Subtest create-close: SUCCESS (0.000s) [163.321596] [033/133] (899s left) kms_plane_multiple (2x-tiling-4) [163.418850] Starting subtest: 2x-tiling-4 [163.423427] Subtest 2x-tiling-4: SKIP (0.000s) [163.513602] [034/133] (899s left) kms_psr (fbc-psr-cursor-mmap-cpu) [163.604300] Starting subtest: fbc-psr-cursor-mmap-cpu [163.606523] Starting dynamic subtest: eDP-1 [163.610921] Dynamic subtest eDP-1: SKIP (0.000s) [163.615471] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [163.688270] [035/133] (899s left) kms_flip (2x-blocking-absolute-wf_vblank) [163.783341] Starting subtest: 2x-blocking-absolute-wf_vblank [163.792239] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [163.942672] [036/133] (898s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [164.038537] Starting subtest: multiplane-rotation-cropping-bottom [171.307527] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.271s) [171.479673] [037/133] (891s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [171.583841] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [171.587214] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [171.692861] [038/133] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [171.793565] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [171.797062] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [171.906889] [039/133] (891s left) kms_ccs (random-ccs-data-y-tiled-ccs) [172.004516] Starting subtest: random-ccs-data-y-tiled-ccs [172.006480] Starting dynamic subtest: pipe-A-eDP-1 [172.029093] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [172.041495] Starting dynamic subtest: pipe-B-eDP-1 [172.061860] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [172.071083] Starting dynamic subtest: pipe-C-eDP-1 [172.090283] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [172.097531] Starting dynamic subtest: pipe-D-eDP-1 [172.118613] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [172.122105] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.006s) [174.261693] [040/133] (888s left) gem_mmap_gtt (big-copy-xy) [174.320592] Subtest big-copy-XY: SKIP (0.000s) [174.381543] [041/133] (888s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [174.473870] Starting subtest: fbcpsr-farfromfence-mmap-gtt [174.477830] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [174.597383] [042/133] (888s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [174.694128] Starting subtest: fbc-rgb565-draw-pwrite [179.287246] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.597s) [180.501785] [043/133] (882s left) kms_cursor_edge_walk (256x256-top-bottom) [180.597843] Starting subtest: 256x256-top-bottom [180.600127] Starting dynamic subtest: pipe-A-eDP-1 [184.027655] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.430s) [184.036190] Starting dynamic subtest: pipe-D-eDP-1 [187.149276] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s) [187.151126] Subtest 256x256-top-bottom: SUCCESS (6.551s) [187.995261] [044/133] (875s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [188.114615] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [205.851096] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.734s) [206.657086] [045/133] (856s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [206.716378] Starting subtest: multi-wait-for-submit-available-submitted-signaled [206.718664] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s) [206.844590] [046/133] (856s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [206.939198] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [206.941520] Starting dynamic subtest: pipe-A-eDP-1 [206.964445] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [206.974722] Starting dynamic subtest: pipe-B-eDP-1 [206.996228] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [207.003610] Starting dynamic subtest: pipe-C-eDP-1 [207.024720] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [207.031752] Starting dynamic subtest: pipe-D-eDP-1 [207.054646] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [207.059526] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [209.230172] [047/133] (854s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [209.330743] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [212.951245] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.624s) [214.123664] [048/133] (849s left) gem_exec_schedule (pi-distinct-iova) [214.307177] Starting subtest: pi-distinct-iova [214.309477] Starting dynamic subtest: rcs0 [214.380454] Dynamic subtest rcs0: SUCCESS (0.075s) [214.388859] Starting dynamic subtest: vcs0 [214.439913] Dynamic subtest vcs0: SUCCESS (0.059s) [214.448084] Starting dynamic subtest: vcs1 [214.505776] Dynamic subtest vcs1: SUCCESS (0.065s) [214.513561] Starting dynamic subtest: vecs0 [214.564443] Dynamic subtest vecs0: SUCCESS (0.057s) [214.572292] Starting dynamic subtest: ccs0 [214.627340] Dynamic subtest ccs0: SUCCESS (0.062s) [214.629613] Subtest pi-distinct-iova: SUCCESS (0.323s) [215.992540] [049/133] (847s left) kms_properties (colorop-properties-atomic) [216.085524] Starting subtest: colorop-properties-atomic [216.087799] Starting dynamic subtest: pipe-A-eDP-1 [216.461672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s) [216.469696] Starting dynamic subtest: pipe-B-eDP-1 [217.562957] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s) [217.572339] Starting dynamic subtest: pipe-C-eDP-1 [218.609080] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.044s) [218.620309] Starting dynamic subtest: pipe-D-eDP-1 [219.642941] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.033s) [219.645797] Subtest colorop-properties-atomic: SUCCESS (3.559s) [220.452386] [050/133] (843s left) kms_setmode (invalid-clone-single-crtc) [220.513815] Starting subtest: invalid-clone-single-crtc [220.520469] Subtest invalid-clone-single-crtc: SKIP (0.000s) [220.621068] [051/133] (842s left) gem_tiled_blits (interruptible) [220.682242] Subtest interruptible: SKIP (0.000s) [220.763616] [052/133] (842s left) gem_mmap_offset (basic-uaf) [220.816482] Starting subtest: basic-uaf [220.818399] Subtest basic-uaf: SUCCESS (0.001s) [220.949118] [053/133] (842s left) gem_spin_batch (engines) [221.007388] Starting subtest: engines [221.009699] Starting dynamic subtest: rcs0 [224.246586] Dynamic subtest rcs0: SUCCESS (3.234s) [224.257768] Starting dynamic subtest: bcs0 [227.485049] Dynamic subtest bcs0: SUCCESS (3.235s) [227.493645] Starting dynamic subtest: vcs0 [230.717731] Dynamic subtest vcs0: SUCCESS (3.229s) [230.726260] Starting dynamic subtest: vcs1 [233.955877] Dynamic subtest vcs1: SUCCESS (3.234s) [233.964202] Starting dynamic subtest: vecs0 [237.192227] Dynamic subtest vecs0: SUCCESS (3.234s) [237.200721] Starting dynamic subtest: ccs0 [240.431048] Dynamic subtest ccs0: SUCCESS (3.235s) [240.433343] Subtest engines: SUCCESS (19.419s) [240.695978] [054/133] (822s left) i915_pm_rps (thresholds-park) [240.776154] Starting subtest: thresholds-park [240.780937] Subtest thresholds-park: SKIP (0.001s) [240.901664] [055/133] (822s left) i915_fb_tiling (basic-x-tiling) [240.955673] Subtest basic-x-tiling: SKIP (0.000s) [241.020587] [056/133] (822s left) prime_busy (hang-wait) [241.081808] Starting subtest: hang-wait [241.084206] Starting dynamic subtest: rcs0 [267.385721] Dynamic subtest rcs0: SUCCESS (26.298s) [267.395046] Starting dynamic subtest: bcs0 [274.533170] Dynamic subtest bcs0: SUCCESS (7.147s) [274.540839] Starting dynamic subtest: vcs0 [281.573811] Dynamic subtest vcs0: SUCCESS (7.036s) [281.581383] Starting dynamic subtest: vcs1 [288.486941] Dynamic subtest vcs1: SUCCESS (6.910s) [288.495192] Starting dynamic subtest: vecs0 [295.525465] Dynamic subtest vecs0: SUCCESS (7.036s) [295.532782] Starting dynamic subtest: ccs0 [309.359305] Dynamic subtest ccs0: SUCCESS (13.830s) [309.362060] Subtest hang-wait: SUCCESS (68.273s) [309.496173] [057/133] (754s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [309.605547] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [309.609985] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [309.734969] [058/133] (754s left) perf (non-zero-reason) [309.873919] Starting subtest: non-zero-reason [309.876163] Starting dynamic subtest: 0-rcs0 [315.246037] Dynamic subtest 0-rcs0: SUCCESS (5.371s) [315.258148] Starting dynamic subtest: 1-vcs1 [319.163228] Dynamic subtest 1-vcs1: SUCCESS (3.916s) [319.166061] Subtest non-zero-reason: SUCCESS (9.289s) [319.208812] [059/133] (744s left) gem_mmap_gtt (basic-small-copy-xy) [319.268654] Subtest basic-small-copy-XY: SKIP (0.000s) [319.332640] [060/133] (744s left) kms_chamelium_hpd (vga-hpd-fast) [319.708380] Subtest vga-hpd-fast: SKIP (0.000s) [320.544326] [061/133] (743s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [320.654263] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [321.688979] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.034s) [321.831494] [062/133] (742s left) device_reset (unbind-cold-reset-rebind) [321.876109] Starting subtest: unbind-cold-reset-rebind [321.880081] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [321.952469] [063/133] (742s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [322.003078] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [322.065527] [064/133] (741s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [322.158491] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [322.160481] Starting dynamic subtest: pipe-A-eDP-1 [322.446707] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.261s) [322.456237] Starting dynamic subtest: pipe-B-eDP-1 [323.748581] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.297s) [323.759343] Starting dynamic subtest: pipe-C-eDP-1 [324.952125] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s) [324.961848] Starting dynamic subtest: pipe-D-eDP-1 [326.193821] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s) [326.196188] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.003s) [327.415852] [065/133] (736s left) prime_self_import (basic-with_one_bo) [327.450588] Starting subtest: basic-with_one_bo [327.478330] Subtest basic-with_one_bo: SUCCESS (0.027s) [327.624203] [066/133] (736s left) kms_big_fb (4-tiled-64bpp-rotate-180) [327.727951] Starting subtest: 4-tiled-64bpp-rotate-180 [329.296362] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.567s) [329.496134] [067/133] (734s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [329.553070] Starting subtest: etime-multi-wait-all-for-submit-submitted [329.657473] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s) [329.763377] [068/133] (734s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [329.857768] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [329.860139] Starting dynamic subtest: A-eDP1 [333.443557] Dynamic subtest A-eDP1: SUCCESS (3.584s) [333.453975] Starting dynamic subtest: B-eDP1 [336.633944] Dynamic subtest B-eDP1: SUCCESS (3.189s) [336.643124] Starting dynamic subtest: C-eDP1 [339.758150] Dynamic subtest C-eDP1: SUCCESS (3.120s) [339.767207] Starting dynamic subtest: D-eDP1 [342.872546] Dynamic subtest D-eDP1: SUCCESS (3.116s) [342.875009] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.018s) [343.684695] [069/133] (720s left) gem_mmap_wc (invalid-flags) [343.732295] Subtest invalid-flags: SKIP (0.000s) [343.787088] [070/133] (720s left) gem_pwrite (basic-self) [343.848774] Subtest basic-self: SKIP (0.000s) [343.907756] [071/133] (720s left) i915_drm_fdinfo (most-busy-check-all) [343.945252] Starting subtest: most-busy-check-all [343.947821] Starting dynamic subtest: rcs0 [343.952582] Dynamic subtest rcs0: SKIP (0.004s) [343.961743] Starting dynamic subtest: bcs0 [343.966207] Dynamic subtest bcs0: SKIP (0.000s) [343.974103] Starting dynamic subtest: vcs0 [343.978440] Dynamic subtest vcs0: SKIP (0.000s) [343.986454] Starting dynamic subtest: vcs1 [343.990883] Dynamic subtest vcs1: SKIP (0.000s) [343.998776] Starting dynamic subtest: vecs0 [344.003180] Dynamic subtest vecs0: SKIP (0.000s) [344.011452] Starting dynamic subtest: ccs0 [344.015869] Dynamic subtest ccs0: SKIP (0.001s) [344.020222] Subtest most-busy-check-all: SKIP (0.009s) [344.056475] [072/133] (720s left) gem_exec_fence (parallel) [344.273076] Starting subtest: parallel [344.275604] Starting dynamic subtest: rcs0 [346.429777] Dynamic subtest rcs0: SUCCESS (2.157s) [346.439885] Starting dynamic subtest: bcs0 [348.579953] Dynamic subtest bcs0: SUCCESS (2.149s) [348.589852] Starting dynamic subtest: vcs0 [350.729503] Dynamic subtest vcs0: SUCCESS (2.149s) [350.737957] Starting dynamic subtest: vcs1 [352.882895] Dynamic subtest vcs1: SUCCESS (2.153s) [352.892536] Starting dynamic subtest: vecs0 [355.031933] Dynamic subtest vecs0: SUCCESS (2.148s) [355.041570] Starting dynamic subtest: ccs0 [357.185557] Dynamic subtest ccs0: SUCCESS (2.153s) [357.187826] Subtest parallel: SUCCESS (12.913s) [357.947432] [073/133] (706s left) perf (unprivileged-single-ctx-counters) [358.047504] Starting subtest: unprivileged-single-ctx-counters [358.051597] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [358.088980] [074/133] (706s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [358.144430] Starting subtest: etime-single-wait-available-unsubmitted [358.249541] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s) [358.349342] [075/133] (706s left) gem_exec_reloc (basic-wc-gtt-noreloc) [358.405480] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [358.476414] [076/133] (706s left) kms_lease (possible-crtcs-filtering) [358.577027] Starting subtest: possible-crtcs-filtering [358.581419] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [358.712199] [077/133] (705s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [358.797143] Starting subtest: extended-pageflip-modeset-hang-oldfb [358.799347] Starting dynamic subtest: pipe-A [366.691090] Dynamic subtest pipe-A: SUCCESS (7.895s) [366.700397] Starting dynamic subtest: pipe-D [375.278711] Dynamic subtest pipe-D: SUCCESS (8.583s) [375.281059] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.482s) [376.150670] [078/133] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [376.252892] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [376.257174] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [376.358421] [079/133] (688s left) syncobj_basic (bad-pad-handle-to-fd) [376.423597] Starting subtest: bad-pad-handle-to-fd [376.425990] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [376.520757] [080/133] (688s left) gem_exec_flush (basic-wb-pro-default) [376.568467] Starting subtest: basic-wb-pro-default [382.023460] Subtest basic-wb-pro-default: SUCCESS (5.457s) [382.223311] [081/133] (682s left) gem_ctx_sseu (mmap-args) [382.292986] Subtest mmap-args: SKIP (0.000s) [382.361021] [082/133] (682s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [382.494478] Starting subtest: nonblocking-modeset-vs-cursor-atomic [383.920880] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.426s) [384.729581] [083/133] (680s left) syncobj_wait (invalid-signal-one-illegal-handle) [384.777986] Starting subtest: invalid-signal-one-illegal-handle [384.780629] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [384.910206] [084/133] (679s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [385.009321] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [385.634510] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.627s) [385.853824] [085/133] (679s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [385.955124] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [385.957406] Starting dynamic subtest: pipe-A [386.064696] Dynamic subtest pipe-A: SKIP (0.107s) [386.073623] Starting dynamic subtest: pipe-B [387.292931] Dynamic subtest pipe-B: SKIP (1.225s) [387.301617] Starting dynamic subtest: pipe-C [388.439938] Dynamic subtest pipe-C: SUCCESS (1.153s) [388.449288] Starting dynamic subtest: pipe-D [389.665589] Dynamic subtest pipe-D: SUCCESS (1.225s) [389.667971] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.714s) [390.856216] [086/133] (674s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [390.958923] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [398.382543] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.425s) [398.527478] [087/133] (666s left) gem_pxp (reject-modify-context-protection-off-3) [398.643238] Starting subtest: reject-modify-context-protection-off-3 [398.645805] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s) [398.776368] [088/133] (666s left) syncobj_timeline (wait-all-for-submit-snapshot) [398.833225] Starting subtest: wait-all-for-submit-snapshot [398.914463] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [399.002468] [089/133] (666s left) kms_color (ctm-signed) [399.085853] Starting subtest: ctm-signed [399.087669] Starting dynamic subtest: pipe-A-eDP-1 [401.157623] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.072s) [401.167594] Starting dynamic subtest: pipe-B-eDP-1 [403.994120] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.833s) [404.003227] Starting dynamic subtest: pipe-C-eDP-1 [406.631595] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.636s) [406.640557] Starting dynamic subtest: pipe-D-eDP-1 [409.304179] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.672s) [409.306139] Subtest ctm-signed: SUCCESS (10.217s) [410.147504] [090/133] (654s left) gem_ccs (suspend-resume) [410.210671] Starting subtest: suspend-resume [410.214856] Subtest suspend-resume: SKIP (0.000s) [410.347328] [091/133] (654s left) kms_writeback (writeback-check-output) [410.443237] Subtest writeback-check-output: SKIP (0.000s) [410.490105] [092/133] (654s left) gem_exec_whisper (basic-normal-all) [410.542561] Starting subtest: basic-normal-all [412.804697] Subtest basic-normal-all: SUCCESS (2.259s) [413.006486] [093/133] (652s left) gem_partial_pwrite_pread (write-snoop) [413.064433] Subtest write-snoop: SKIP (0.000s) [413.148439] [094/133] (652s left) kms_vblank (ts-continuation-modeset-rpm) [413.234252] Starting subtest: ts-continuation-modeset-rpm [413.236462] Starting dynamic subtest: pipe-A-eDP-1 [415.731561] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [415.744822] Starting dynamic subtest: pipe-D-eDP-1 [417.974065] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.240s) [417.976387] Subtest ts-continuation-modeset-rpm: SUCCESS (4.740s) [418.870876] [095/133] (646s left) kms_frontbuffer_tracking (fbc-stridechange) [418.970334] Starting subtest: fbc-stridechange [422.269762] Subtest fbc-stridechange: SUCCESS (3.302s) [423.461376] [096/133] (641s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [428.508731] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [428.511099] Starting dynamic subtest: pipe-A-eDP-1 [429.314559] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s) [429.324468] Starting dynamic subtest: pipe-B-eDP-1 [430.445657] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s) [430.450092] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.935s) [431.645933] [097/133] (633s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [431.748605] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [431.753021] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [431.874794] [098/133] (633s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [436.921209] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [436.923514] Starting dynamic subtest: pipe-A-eDP-1 [443.522131] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.600s) [443.532263] Starting dynamic subtest: pipe-B-eDP-1 [450.158960] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.633s) [450.161169] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.237s) [451.055433] [099/133] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [451.161278] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [451.165770] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [451.301367] [100/133] (614s left) kms_invalid_mode (bad-vsync-end) [451.403128] Starting subtest: bad-vsync-end [451.405393] Starting dynamic subtest: pipe-A-eDP-1 [451.690316] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s) [451.701126] Starting dynamic subtest: pipe-B-eDP-1 [451.703121] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [451.711589] Starting dynamic subtest: pipe-C-eDP-1 [451.713757] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [451.722076] Starting dynamic subtest: pipe-D-eDP-1 [451.724478] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [451.726913] Subtest bad-vsync-end: SUCCESS (0.293s) [452.579790] [101/133] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [452.685812] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [452.689948] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [452.806729] [102/133] (612s left) gem_ctx_persistence (heartbeat-hang) [452.868136] Starting subtest: heartbeat-hang [452.872929] Subtest heartbeat-hang: SKIP (0.000s) [453.006197] [103/133] (612s left) kms_flip_tiling (flip-change-tiling) [453.096009] Starting subtest: flip-change-tiling [453.098232] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [453.301823] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.206s) [453.313290] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [453.436871] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [453.447500] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [453.580831] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [453.591232] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [453.724252] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [453.735708] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [453.868340] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [453.880084] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [454.012837] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [454.024185] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [454.146143] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [454.155375] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [454.257905] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [454.269099] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [454.392066] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [454.402038] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [454.535726] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [454.551615] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [454.679336] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [454.691406] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [454.823557] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [454.835113] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [454.957985] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [454.969900] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [455.092467] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [455.104292] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [455.202501] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [455.214114] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [455.346950] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [455.359559] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [455.490714] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [455.503624] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [455.635034] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [455.646756] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [455.779598] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [455.791307] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [455.924525] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [455.936105] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [456.069394] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [456.081110] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [456.191225] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s) [456.202988] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [456.334511] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s) [456.348302] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [456.479172] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [456.490187] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [456.623666] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [456.637287] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [456.768322] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [456.779584] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [456.912346] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [456.925219] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [457.057123] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s) [457.068745] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [457.218127] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.159s) [457.230988] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [457.362750] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s) [457.374437] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [457.506531] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [457.520208] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [457.651032] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [457.664759] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [457.796517] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [457.808029] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [457.940063] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s) [457.953961] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [458.084904] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s) [458.099861] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [458.218267] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.131s) [458.269799] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [459.531064] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.267s) [459.542814] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [459.665466] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [459.680645] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [459.798520] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [459.809360] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [459.942605] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [459.954113] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [460.085731] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [460.101524] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [460.230156] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.141s) [460.244539] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [460.376691] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s) [460.388370] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [460.497986] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s) [460.509641] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [460.631930] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [460.641970] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [460.775321] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [460.791280] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [460.918889] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.143s) [460.930845] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [461.063947] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [461.076100] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [461.208627] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.143s) [461.219440] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [461.343384] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [461.354941] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [461.453047] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [461.465134] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [461.597589] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [461.609080] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [461.752582] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.153s) [461.764082] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [461.896874] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [461.907228] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [462.041574] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [462.053738] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [462.186563] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [462.197300] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [462.330886] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [462.341836] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [462.452356] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s) [462.464145] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [462.596902] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s) [462.607672] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [462.742318] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s) [462.754506] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [462.885400] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [462.899486] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [463.029937] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [463.043522] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [463.174250] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [463.188276] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [463.319083] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s) [463.330813] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [463.442416] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s) [463.453920] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [463.585828] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [463.599378] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [463.730059] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [463.742780] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [463.875574] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [463.887139] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [464.019262] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [464.034509] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [464.191509] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.170s) [464.201967] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [464.335666] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s) [464.346899] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [464.457714] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s) [464.509530] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [465.761404] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.257s) [465.773098] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [465.860975] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [465.872326] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [465.972748] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [465.983675] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [466.121913] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.147s) [466.132070] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [466.232781] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [466.245595] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [466.343712] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [466.354950] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [466.455223] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s) [466.469758] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [466.566686] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [466.580800] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [466.677909] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [466.691789] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [466.788344] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [466.800099] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [466.898950] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [466.910336] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [467.009878] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [467.020570] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [467.110559] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [467.121385] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [467.210590] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [467.219137] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [467.310289] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s) [467.321691] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [467.421739] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [467.435516] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [467.532308] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.108s) [467.541833] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [467.643402] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s) [467.654071] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [467.743968] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s) [467.755618] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [467.844118] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s) [467.852765] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [467.954847] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [467.969069] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [468.066035] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.108s) [468.077345] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [468.177225] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s) [468.192229] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [468.287965] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s) [468.299358] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [468.399103] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s) [468.411570] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [468.510476] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [468.526020] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [468.621226] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.108s) [468.632032] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [468.732537] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s) [468.746434] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [468.843952] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s) [468.855070] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [468.955108] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s) [468.967857] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [469.066338] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [469.077321] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [469.176892] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [469.188049] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [469.288041] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [469.298945] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [469.399043] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s) [469.410055] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [469.510547] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s) [469.522532] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [469.623398] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s) [469.664188] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [470.891374] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.233s) [470.903023] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [470.991306] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [471.002694] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [471.091491] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s) [471.103096] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [471.202460] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [471.212061] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [471.312952] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [471.324168] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [471.462841] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.148s) [471.473245] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [471.574180] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s) [471.589341] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [471.685686] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [471.700308] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [471.796670] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [471.811420] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [471.907453] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [471.918961] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [472.018842] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [472.029757] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [472.129081] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s) [472.140819] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [472.229514] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [472.244299] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [472.329650] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [472.341391] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [472.429377] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [472.440061] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [472.540202] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s) [472.551315] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [472.651565] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [472.666113] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [472.762522] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [472.773592] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [472.874049] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s) [472.885915] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [472.984948] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [472.996366] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [473.096344] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [473.107867] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [473.207474] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [473.220241] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [473.330049] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.118s) [473.340389] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [473.440157] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s) [473.451180] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [473.551304] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s) [473.562029] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [473.651053] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s) [473.662329] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [473.762415] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s) [473.773083] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [473.873335] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s) [473.884487] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [473.984753] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s) [473.998725] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [474.107195] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.120s) [474.119627] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [474.218096] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.108s) [474.229404] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [474.317744] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s) [474.328348] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [474.418066] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.099s) [474.428196] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [474.529163] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s) [474.539865] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [474.640855] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s) [474.652548] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [474.751703] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [474.784591] Subtest flip-change-tiling: SUCCESS (21.690s) [476.006600] [104/133] (589s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [476.096245] Starting subtest: fbc-psr2-cursor-mmap-cpu [476.098577] Starting dynamic subtest: eDP-1 [476.102742] Dynamic subtest eDP-1: SKIP (0.000s) [476.106898] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [476.183136] [105/133] (589s left) kms_chamelium_frames (dp-crc-fast) [476.563691] Subtest dp-crc-fast: SKIP (0.000s) [477.389936] [106/133] (588s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [477.495459] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [477.497752] Starting dynamic subtest: pipe-A-eDP-1 [477.519270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [477.529922] Starting dynamic subtest: pipe-B-eDP-1 [477.550972] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [477.560087] Starting dynamic subtest: pipe-C-eDP-1 [477.580587] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s) [477.589542] Starting dynamic subtest: pipe-D-eDP-1 [477.610156] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [477.612336] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s) [479.877786] [107/133] (585s left) kms_colorop (plane-xr24-xr24-srgb_inv_eotf_lut) [480.008422] Subtest plane-XR24-XR24-srgb_inv_eotf_lut: SKIP (0.000s) [480.085404] [108/133] (585s left) kms_draw_crc (draw-method-pwrite) [480.178326] Starting subtest: draw-method-pwrite [480.180229] Starting dynamic subtest: xrgb8888-untiled [480.765424] Dynamic subtest xrgb8888-untiled: SUCCESS (0.589s) [480.774605] Starting dynamic subtest: rgb565-untiled [481.198639] Dynamic subtest rgb565-untiled: SUCCESS (0.432s) [481.207690] Starting dynamic subtest: xrgb2101010-untiled [481.743836] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s) [481.752706] Starting dynamic subtest: xbgr16161616f-untiled [482.499088] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s) [482.507837] Starting dynamic subtest: xrgb8888-xtiled [484.210366] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.710s) [484.219249] Starting dynamic subtest: rgb565-xtiled [485.244036] Dynamic subtest rgb565-xtiled: SUCCESS (1.033s) [485.258566] Starting dynamic subtest: xrgb2101010-xtiled [486.954367] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.709s) [486.964991] Starting dynamic subtest: xbgr16161616f-xtiled [490.132710] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.177s) [490.142065] Starting dynamic subtest: xrgb8888-4tiled [491.199614] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.066s) [491.208636] Starting dynamic subtest: rgb565-4tiled [491.743891] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s) [491.753200] Starting dynamic subtest: xrgb2101010-4tiled [492.799492] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.055s) [492.809193] Starting dynamic subtest: xbgr16161616f-4tiled [495.677950] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.877s) [495.680348] Subtest draw-method-pwrite: SUCCESS (15.501s) [495.827032] [109/133] (570s left) gem_exec_params (dr4-dirt) [495.891551] Starting subtest: DR4-dirt [495.893438] Subtest DR4-dirt: SUCCESS (0.000s) [496.013079] [110/133] (569s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [496.114830] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [496.117166] Starting dynamic subtest: pipe-A-default-mode [496.421607] Dynamic subtest pipe-A-default-mode: SKIP (0.303s) [496.426472] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.305s) [497.299765] [111/133] (568s left) kms_cursor_crc (cursor-random-64x21) [497.487796] Starting subtest: cursor-random-64x21 [497.534198] Subtest cursor-random-64x21: SKIP (0.044s) [497.791087] [112/133] (568s left) kms_big_fb (y-tiled-64bpp-rotate-270) [497.889093] Starting subtest: y-tiled-64bpp-rotate-270 [497.893284] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [498.014767] [113/133] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [498.122740] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [505.442516] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.321s) [505.587445] [114/133] (560s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [505.682043] Starting subtest: plane-downscale-factor-0-5-with-rotation [505.684331] Starting dynamic subtest: pipe-A [505.701965] Dynamic subtest pipe-A: SKIP (0.017s) [505.711203] Starting dynamic subtest: pipe-B [505.734565] Dynamic subtest pipe-B: SKIP (0.031s) [505.743306] Starting dynamic subtest: pipe-C [505.771444] Dynamic subtest pipe-C: SKIP (0.031s) [505.780060] Starting dynamic subtest: pipe-D [505.797384] Dynamic subtest pipe-D: SKIP (0.031s) [505.801293] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.113s) [505.902889] [115/133] (560s left) kms_concurrent (multi-plane-atomic-lowres) [506.000049] Starting subtest: multi-plane-atomic-lowres [506.002347] Starting dynamic subtest: pipe-A-eDP-1 [506.491621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.489s) [506.494094] Subtest multi-plane-atomic-lowres: SUCCESS (0.491s) [507.353377] [116/133] (558s left) i915_pm_rpm (sysfs-read) [509.083309] Starting subtest: sysfs-read [510.240681] Subtest sysfs-read: SUCCESS (1.156s) [510.647337] [117/133] (555s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [510.695797] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [510.698168] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [510.826280] [118/133] (555s left) kms_universal_plane (universal-plane-functional) [510.915268] Starting subtest: universal-plane-functional [510.917538] Starting dynamic subtest: pipe-A-eDP-1 [514.886227] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.969s) [514.895481] Starting dynamic subtest: pipe-B-eDP-1 [519.377896] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.491s) [519.387089] Starting dynamic subtest: pipe-C-eDP-1 [523.735469] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.355s) [523.744372] Starting dynamic subtest: pipe-D-eDP-1 [528.103566] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.366s) [528.105904] Subtest universal-plane-functional: SUCCESS (17.187s) [528.913554] [119/133] (537s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [528.972770] Starting subtest: y-tiled-ccs-to-yf-tiled [528.977204] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [529.169104] [120/133] (537s left) kms_psr (psr2-sprite-mmap-cpu) [529.266303] Starting subtest: psr2-sprite-mmap-cpu [529.268834] Starting dynamic subtest: eDP-1 [530.991788] Dynamic subtest eDP-1: SUCCESS (1.726s) [530.994194] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.727s) [531.865416] [121/133] (534s left) kms_pm_lpsp (kms-lpsp) [532.962652] Starting subtest: kms-lpsp [532.965039] Starting dynamic subtest: pipe-A-eDP-1 [533.109693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s) [533.409060] Subtest kms-lpsp: SUCCESS (0.447s) [534.311629] [122/133] (532s left) syncobj_eventfd (invalid-bad-pad) [534.369675] Starting subtest: invalid-bad-pad [534.371620] Subtest invalid-bad-pad: SUCCESS (0.000s) [534.496751] [123/133] (531s left) gem_readwrite (read-bad-handle) [534.553463] Subtest read-bad-handle: SKIP (0.000s) [534.620529] [124/133] (531s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [534.713735] Starting subtest: psr-rgb565-draw-render [541.844940] Subtest psr-rgb565-draw-render: SUCCESS (7.132s) [542.004573] [125/133] (524s left) gem_spin_batch (user-each) [542.079817] Starting subtest: user-each [545.437919] Subtest user-each: SUCCESS (3.359s) [545.951558] [126/133] (520s left) syncobj_basic (bad-destroy-pad) [546.013768] Starting subtest: bad-destroy-pad [546.016246] Subtest bad-destroy-pad: SUCCESS (0.000s) [546.141581] [127/133] (520s left) kms_addfb_basic (basic-y-tiled-legacy) [546.197222] Starting subtest: basic-y-tiled-legacy [546.201642] Subtest basic-y-tiled-legacy: SKIP (0.000s) [546.357523] [128/133] (520s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [546.457997] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [546.460283] Starting dynamic subtest: pipe-A-eDP-1 [546.469326] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [546.479585] Starting dynamic subtest: pipe-B-eDP-1 [546.488304] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [546.498511] Starting dynamic subtest: pipe-C-eDP-1 [546.506921] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [546.515308] Starting dynamic subtest: pipe-D-eDP-1 [546.523789] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [546.528138] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [548.703438] [129/133] (518s left) kms_rotation_crc (primary-rotation-180) [548.800197] Starting subtest: primary-rotation-180 [555.766227] Subtest primary-rotation-180: SUCCESS (6.967s) [556.969028] [130/133] (509s left) prime_vgem (fence-write-hang) [557.045930] Subtest fence-write-hang: SKIP (0.000s) [557.163069] [131/133] (509s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [557.267611] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [557.271831] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [557.383975] [132/133] (509s left) gem_exec_balancer (indices) [557.450765] Starting subtest: indices [559.856701] Subtest indices: SUCCESS (2.408s) [560.177295] [133/133] (506s left) prime_mmap (test_forked_cpu_write) [560.239791] Starting subtest: test_forked_cpu_write [560.242152] Starting dynamic subtest: test_forked_cpu_write-smem [560.247435] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [560.249794] Subtest test_forked_cpu_write: SUCCESS (0.009s) [560.371454] 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.