[59.997714] Initializing watchdogs [59.997810] /dev/watchdog0 [60.012960] [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] [60.017686] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.019998] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.023429] [001/133] (960s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [60.094672] Starting subtest: multi-wait-for-submit-submitted-signaled [60.097068] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [60.222160] [002/133] (960s left) syncobj_wait (wait-for-submit-snapshot) [60.281641] Starting subtest: wait-for-submit-snapshot [60.362320] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [60.450031] [003/133] (960s left) gem_blits (basic) [60.513682] Starting subtest: basic [62.570648] Subtest basic: SUCCESS (2.071s) [62.710172] [004/133] (957s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [62.810632] Starting subtest: yf-tiled-8bpp-rotate-180 [62.815085] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [62.934095] [005/133] (957s left) kms_async_flips (test-cursor) [63.024271] Starting subtest: test-cursor [63.028464] Subtest test-cursor: SKIP (0.000s) [64.201945] [006/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [64.296714] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [64.301251] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [64.400585] [007/133] (956s left) kms_pm_rpm (pm-caching) [66.050624] Starting subtest: pm-caching [66.056161] Subtest pm-caching: SKIP (0.000s) [66.730300] [008/133] (954s left) gem_exercise_blt (fast-copy-emit) [66.786597] Starting subtest: fast-copy-emit [66.788735] Starting dynamic subtest: linear-smem-smem-emit [66.808527] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s) [66.816761] Starting dynamic subtest: xmajor-smem-smem-emit [66.825709] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s) [66.835067] Starting dynamic subtest: tile4-smem-smem-emit [66.844945] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.019s) [66.851643] Starting dynamic subtest: tile64-smem-smem-emit [66.862059] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s) [66.864356] Subtest fast-copy-emit: SUCCESS (0.076s) [67.008890] [009/133] (953s left) vgem_slow (nohang) [67.109941] Starting subtest: nohang [77.425415] Subtest nohang: SUCCESS (10.337s) [77.509128] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true [77.512087] [010/133] (943s left) kms_content_protection (lic-type-0) [77.658014] Starting subtest: lic-type-0 [77.662600] Subtest lic-type-0: SKIP (0.000s) [77.822662] [011/133] (943s left) kms_feature_discovery (display-3x) [77.907786] Starting subtest: display-3x [77.912268] Subtest display-3x: SKIP (0.000s) [77.992149] [012/133] (942s left) gem_mmap_gtt (cpuset-medium-copy-xy) [78.054423] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [78.121386] [013/133] (942s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [78.240968] Starting subtest: cursorA-vs-flipA-varying-size [89.395071] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.156s) [90.226331] [014/133] (930s left) gen7_exec_parse (load-register-reg) [90.282723] Subtest load-register-reg: SKIP (0.000s) [90.358139] [015/133] (930s left) gem_exec_fence (syncobj-wait) [90.766921] Starting subtest: syncobj-wait [91.970879] Subtest syncobj-wait: SUCCESS (1.204s) [92.344293] [016/133] (928s left) gem_mmap_wc (write-read-distinct) [92.406463] Subtest write-read-distinct: SKIP (0.000s) [92.468724] [017/133] (928s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [92.567589] Starting subtest: psr-rgb101010-draw-mmap-wc [99.591755] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.027s) [99.716731] [018/133] (921s left) kms_joiner (basic-ultra-joiner) [99.815296] Subtest basic-ultra-joiner: SKIP (0.000s) [99.896807] [019/133] (921s left) gem_ctx_isolation (nonpriv-switch) [99.955973] Starting subtest: nonpriv-switch [99.958405] Starting dynamic subtest: rcs0 [100.233410] Dynamic subtest rcs0: SUCCESS (0.277s) [100.242376] Starting dynamic subtest: bcs0 [100.558932] Dynamic subtest bcs0: SUCCESS (0.326s) [100.569270] Starting dynamic subtest: vcs0 [100.880514] Dynamic subtest vcs0: SUCCESS (0.321s) [100.887729] Starting dynamic subtest: vcs1 [102.187701] Dynamic subtest vcs1: SUCCESS (1.306s) [102.195319] Starting dynamic subtest: vecs0 [104.238789] Dynamic subtest vecs0: SUCCESS (2.051s) [104.247464] Starting dynamic subtest: ccs0 [106.292881] Dynamic subtest ccs0: SUCCESS (2.054s) [106.295353] Subtest nonpriv-switch: SUCCESS (6.337s) [106.546757] [020/133] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [106.651606] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [113.268475] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.618s) [113.431628] [021/133] (907s left) kms_cursor_crc (cursor-sliding-128x42) [113.656882] Starting subtest: cursor-sliding-128x42 [113.710976] Subtest cursor-sliding-128x42: SKIP (0.049s) [113.951272] [022/133] (907s left) gem_ctx_bad_destroy (invalid-default-ctx) [114.007742] Starting subtest: invalid-default-ctx [114.010134] Subtest invalid-default-ctx: SUCCESS (0.000s) [114.092655] [023/133] (907s left) kms_psr (fbc-psr-suspend) [114.176056] Starting subtest: fbc-psr-suspend [114.178342] Starting dynamic subtest: eDP-1 [114.182720] Dynamic subtest eDP-1: SKIP (0.000s) [114.187249] Subtest fbc-psr-suspend: SKIP (0.001s) [114.267639] [024/133] (907s left) api_intel_bb (reset-bb) [114.322332] Starting subtest: reset-bb [114.324046] Subtest reset-bb: SUCCESS (0.004s) [114.481982] [025/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [114.579076] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [114.582487] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [114.703840] [026/133] (906s left) gem_exec_schedule (u-fairslice-all) [114.778533] Starting subtest: u-fairslice-all [116.837037] Subtest u-fairslice-all: SUCCESS (2.057s) [117.139123] [027/133] (904s left) kms_flip (flip-vs-fences) [117.239281] Starting subtest: flip-vs-fences [117.243687] Subtest flip-vs-fences: SKIP (0.000s) [117.367762] [028/133] (904s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [117.467406] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [118.556600] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s) [118.701204] [029/133] (902s left) gem_exec_capture (capture-recoverable) [118.769972] Starting subtest: capture-recoverable [118.771877] Subtest capture-recoverable: SUCCESS (0.003s) [118.933212] [030/133] (902s left) drm_read (empty-block) [119.070038] Starting subtest: empty-block [120.069865] Subtest empty-block: SUCCESS (1.000s) [120.238463] [031/133] (901s left) kms_rotation_crc (bad-tiling) [120.333345] Starting subtest: bad-tiling [120.337803] Subtest bad-tiling: SKIP (0.001s) [120.430916] [032/133] (901s left) gem_basic (create-close) [120.483830] Starting subtest: create-close [120.488124] Subtest create-close: SUCCESS (0.000s) [120.643438] [033/133] (901s left) kms_plane_multiple (2x-tiling-4) [120.733261] Starting subtest: 2x-tiling-4 [120.737691] Subtest 2x-tiling-4: SKIP (0.000s) [120.845044] [034/133] (900s left) kms_psr (fbc-psr-cursor-mmap-cpu) [120.946918] Starting subtest: fbc-psr-cursor-mmap-cpu [120.949280] Starting dynamic subtest: eDP-1 [120.953585] Dynamic subtest eDP-1: SKIP (0.000s) [120.957603] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.002s) [121.044816] [035/133] (900s left) kms_flip (2x-blocking-absolute-wf_vblank) [121.144736] Starting subtest: 2x-blocking-absolute-wf_vblank [121.153640] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s) [121.287885] [036/133] (900s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [121.387065] Starting subtest: multiplane-rotation-cropping-bottom [128.601522] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.216s) [128.773293] [037/133] (893s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [128.879374] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [128.882854] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [129.007557] [038/133] (892s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [129.109374] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [129.112885] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [129.248741] [039/133] (892s left) kms_ccs (random-ccs-data-y-tiled-ccs) [129.343206] Starting subtest: random-ccs-data-y-tiled-ccs [129.345137] Starting dynamic subtest: pipe-A-eDP-1 [129.366309] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [129.374659] Starting dynamic subtest: pipe-B-eDP-1 [129.394486] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [129.402039] Starting dynamic subtest: pipe-C-eDP-1 [129.421475] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [129.428739] Starting dynamic subtest: pipe-D-eDP-1 [129.448717] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [129.452050] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s) [131.574566] [040/133] (890s left) gem_mmap_gtt (big-copy-xy) [131.629409] Subtest big-copy-XY: SKIP (0.000s) [131.692889] [041/133] (890s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [131.779573] Starting subtest: fbcpsr-farfromfence-mmap-gtt [131.783887] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [131.901431] [042/133] (890s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [131.991404] Starting subtest: fbc-rgb565-draw-pwrite [136.543927] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.555s) [137.766719] [043/133] (884s left) kms_cursor_edge_walk (256x256-top-bottom) [137.858409] Starting subtest: 256x256-top-bottom [137.860757] Starting dynamic subtest: pipe-A-eDP-1 [141.298813] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s) [141.307320] Starting dynamic subtest: pipe-D-eDP-1 [144.399297] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.100s) [144.402240] Subtest 256x256-top-bottom: SUCCESS (6.543s) [145.224188] [044/133] (876s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [145.343434] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [163.144123] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.797s) [163.947214] [045/133] (858s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [164.010578] Starting subtest: multi-wait-for-submit-available-submitted-signaled [164.013015] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [164.126480] [046/133] (858s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [164.228100] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [164.230594] Starting dynamic subtest: pipe-A-eDP-1 [164.253027] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [164.263174] Starting dynamic subtest: pipe-B-eDP-1 [164.284295] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [164.291682] Starting dynamic subtest: pipe-C-eDP-1 [164.312758] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [164.319864] Starting dynamic subtest: pipe-D-eDP-1 [164.341754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [164.346179] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [166.526027] [047/133] (855s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [166.633109] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [170.239476] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.610s) [171.440366] [048/133] (850s left) gem_exec_schedule (pi-distinct-iova) [171.619951] Starting subtest: pi-distinct-iova [171.622319] Starting dynamic subtest: rcs0 [171.690063] Dynamic subtest rcs0: SUCCESS (0.073s) [171.700846] Starting dynamic subtest: vcs0 [171.755883] Dynamic subtest vcs0: SUCCESS (0.064s) [171.764961] Starting dynamic subtest: vcs1 [171.815384] Dynamic subtest vcs1: SUCCESS (0.059s) [171.824947] Starting dynamic subtest: vecs0 [171.867290] Dynamic subtest vecs0: SUCCESS (0.051s) [171.875062] Starting dynamic subtest: ccs0 [171.931656] Dynamic subtest ccs0: SUCCESS (0.064s) [171.934044] Subtest pi-distinct-iova: SUCCESS (0.317s) [173.007485] [049/133] (849s left) kms_properties (colorop-properties-atomic) [173.097828] Starting subtest: colorop-properties-atomic [173.100257] Starting dynamic subtest: pipe-A-eDP-1 [173.455221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s) [173.462920] Starting dynamic subtest: pipe-B-eDP-1 [174.576537] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.122s) [174.584668] Starting dynamic subtest: pipe-C-eDP-1 [175.615832] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.038s) [175.626838] Starting dynamic subtest: pipe-D-eDP-1 [176.654357] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.037s) [176.656970] Subtest colorop-properties-atomic: SUCCESS (3.559s) [177.479393] [050/133] (844s left) kms_setmode (invalid-clone-single-crtc) [177.529176] Starting subtest: invalid-clone-single-crtc [177.535735] Subtest invalid-clone-single-crtc: SKIP (0.000s) [177.665617] [051/133] (844s left) gem_tiled_blits (interruptible) [177.717650] Subtest interruptible: SKIP (0.000s) [177.772432] [052/133] (844s left) gem_mmap_offset (basic-uaf) [177.813974] Starting subtest: basic-uaf [177.816298] Subtest basic-uaf: SUCCESS (0.001s) [177.925411] [053/133] (844s left) gem_spin_batch (engines) [177.983435] Starting subtest: engines [177.985867] Starting dynamic subtest: rcs0 [181.224440] Dynamic subtest rcs0: SUCCESS (3.236s) [181.234375] Starting dynamic subtest: bcs0 [184.460803] Dynamic subtest bcs0: SUCCESS (3.233s) [184.469527] Starting dynamic subtest: vcs0 [187.697536] Dynamic subtest vcs0: SUCCESS (3.233s) [187.705497] Starting dynamic subtest: vcs1 [190.932932] Dynamic subtest vcs1: SUCCESS (3.234s) [190.942854] Starting dynamic subtest: vecs0 [194.172472] Dynamic subtest vecs0: SUCCESS (3.236s) [194.182949] Starting dynamic subtest: ccs0 [197.437492] Dynamic subtest ccs0: SUCCESS (3.235s) [197.440089] Subtest engines: SUCCESS (19.423s) [197.653740] [054/133] (824s left) i915_pm_rps (thresholds-park) [197.716130] Starting subtest: thresholds-park [197.720885] Subtest thresholds-park: SKIP (0.001s) [197.833164] [055/133] (824s left) i915_fb_tiling (basic-x-tiling) [197.892903] Subtest basic-x-tiling: SKIP (0.000s) [197.957388] [056/133] (824s left) prime_busy (hang-wait) [198.022611] Starting subtest: hang-wait [198.025105] Starting dynamic subtest: rcs0 [224.376541] Dynamic subtest rcs0: SUCCESS (26.349s) [224.383603] Starting dynamic subtest: bcs0 [231.593787] Dynamic subtest bcs0: SUCCESS (7.214s) [231.603508] Starting dynamic subtest: vcs0 [238.566187] Dynamic subtest vcs0: SUCCESS (6.970s) [238.579224] Starting dynamic subtest: vcs1 [245.542040] Dynamic subtest vcs1: SUCCESS (6.973s) [245.550916] Starting dynamic subtest: vecs0 [252.512457] Dynamic subtest vecs0: SUCCESS (6.973s) [252.520402] Starting dynamic subtest: ccs0 [266.419118] Dynamic subtest ccs0: SUCCESS (13.900s) [266.422049] Subtest hang-wait: SUCCESS (68.393s) [266.558178] [057/133] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [266.677483] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [266.681772] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [266.793306] [058/133] (755s left) perf (non-zero-reason) [266.925611] Starting subtest: non-zero-reason [266.927859] Starting dynamic subtest: 0-rcs0 [272.300942] Dynamic subtest 0-rcs0: SUCCESS (5.374s) [272.311745] Starting dynamic subtest: 1-vecs0 [276.206381] Dynamic subtest 1-vecs0: SUCCESS (3.904s) [276.209182] Subtest non-zero-reason: SUCCESS (9.280s) [276.246129] [059/133] (746s left) gem_mmap_gtt (basic-small-copy-xy) [276.311126] Subtest basic-small-copy-XY: SKIP (0.000s) [276.378731] [060/133] (746s left) kms_chamelium_hpd (vga-hpd-fast) [276.761587] Subtest vga-hpd-fast: SKIP (0.000s) [277.554902] [061/133] (745s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [277.652727] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [278.676588] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.023s) [278.799089] [062/133] (744s left) device_reset (unbind-cold-reset-rebind) [278.849622] Starting subtest: unbind-cold-reset-rebind [278.853312] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [278.934912] [063/133] (744s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [278.995198] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [279.087906] [064/133] (743s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [279.185467] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [279.187368] Starting dynamic subtest: pipe-A-eDP-1 [279.461482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.251s) [279.473868] Starting dynamic subtest: pipe-B-eDP-1 [280.778069] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.307s) [280.786252] Starting dynamic subtest: pipe-C-eDP-1 [282.077050] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s) [282.087445] Starting dynamic subtest: pipe-D-eDP-1 [283.294157] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s) [283.296032] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.079s) [284.517100] [065/133] (738s left) prime_self_import (basic-with_one_bo) [284.550717] Starting subtest: basic-with_one_bo [284.572137] Subtest basic-with_one_bo: SUCCESS (0.023s) [284.707381] [066/133] (738s left) kms_big_fb (4-tiled-64bpp-rotate-180) [284.799393] Starting subtest: 4-tiled-64bpp-rotate-180 [286.391279] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.590s) [286.571896] [067/133] (736s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [286.632628] Starting subtest: etime-multi-wait-all-for-submit-submitted [286.739045] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s) [286.826102] [068/133] (736s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [286.907139] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [286.909603] Starting dynamic subtest: A-eDP1 [290.526711] Dynamic subtest A-eDP1: SUCCESS (3.616s) [290.542287] Starting dynamic subtest: B-eDP1 [293.723489] Dynamic subtest B-eDP1: SUCCESS (3.195s) [293.732443] Starting dynamic subtest: C-eDP1 [296.833047] Dynamic subtest C-eDP1: SUCCESS (3.110s) [296.843083] Starting dynamic subtest: D-eDP1 [299.956208] Dynamic subtest D-eDP1: SUCCESS (3.119s) [299.958700] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.049s) [300.777888] [069/133] (722s left) gem_mmap_wc (invalid-flags) [300.842080] Subtest invalid-flags: SKIP (0.000s) [300.906046] [070/133] (722s left) gem_pwrite (basic-self) [300.961701] Subtest basic-self: SKIP (0.000s) [301.027188] [071/133] (722s left) i915_drm_fdinfo (most-busy-check-all) [301.067081] Starting subtest: most-busy-check-all [301.069463] Starting dynamic subtest: rcs0 [301.074540] Dynamic subtest rcs0: SKIP (0.004s) [301.084304] Starting dynamic subtest: bcs0 [301.088732] Dynamic subtest bcs0: SKIP (0.000s) [301.096670] Starting dynamic subtest: vcs0 [301.100774] Dynamic subtest vcs0: SKIP (0.000s) [301.108024] Starting dynamic subtest: vcs1 [301.112151] Dynamic subtest vcs1: SKIP (0.000s) [301.120178] Starting dynamic subtest: vecs0 [301.124261] Dynamic subtest vecs0: SKIP (0.000s) [301.132201] Starting dynamic subtest: ccs0 [301.136447] Dynamic subtest ccs0: SKIP (0.000s) [301.140374] Subtest most-busy-check-all: SKIP (0.009s) [301.175371] [072/133] (722s left) gem_exec_fence (parallel) [301.384340] Starting subtest: parallel [301.386226] Starting dynamic subtest: rcs0 [303.534787] Dynamic subtest rcs0: SUCCESS (2.153s) [303.543557] Starting dynamic subtest: bcs0 [305.684900] Dynamic subtest bcs0: SUCCESS (2.149s) [305.694589] Starting dynamic subtest: vcs0 [307.839481] Dynamic subtest vcs0: SUCCESS (2.154s) [307.847346] Starting dynamic subtest: vcs1 [309.993653] Dynamic subtest vcs1: SUCCESS (2.153s) [310.002901] Starting dynamic subtest: vecs0 [312.146707] Dynamic subtest vecs0: SUCCESS (2.151s) [312.155948] Starting dynamic subtest: ccs0 [314.300574] Dynamic subtest ccs0: SUCCESS (2.153s) [314.302588] Subtest parallel: SUCCESS (12.919s) [315.033965] [073/133] (708s left) perf (unprivileged-single-ctx-counters) [315.136635] Starting subtest: unprivileged-single-ctx-counters [315.141401] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [315.177926] [074/133] (708s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [315.221662] Starting subtest: etime-single-wait-available-unsubmitted [315.322090] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.102s) [315.413449] [075/133] (708s left) gem_exec_reloc (basic-wc-gtt-noreloc) [315.472765] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [315.548364] [076/133] (707s left) kms_lease (possible-crtcs-filtering) [315.647956] Starting subtest: possible-crtcs-filtering [315.653167] Subtest possible-crtcs-filtering: SUCCESS (0.006s) [315.802968] [077/133] (707s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [315.902515] Starting subtest: extended-pageflip-modeset-hang-oldfb [315.904286] Starting dynamic subtest: pipe-A [323.814416] Dynamic subtest pipe-A: SUCCESS (7.909s) [323.823288] Starting dynamic subtest: pipe-D [332.375995] Dynamic subtest pipe-D: SUCCESS (8.560s) [332.378255] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.474s) [333.253422] [078/133] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [333.345636] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [333.349667] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [333.474510] [079/133] (690s left) syncobj_basic (bad-pad-handle-to-fd) [333.523449] Starting subtest: bad-pad-handle-to-fd [333.525642] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [333.652234] [080/133] (689s left) gem_exec_flush (basic-wb-pro-default) [333.715597] Starting subtest: basic-wb-pro-default [339.171914] Subtest basic-wb-pro-default: SUCCESS (5.456s) [339.360086] [081/133] (684s left) gem_ctx_sseu (mmap-args) [339.421740] Subtest mmap-args: SKIP (0.000s) [339.507143] [082/133] (684s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [339.630362] Starting subtest: nonblocking-modeset-vs-cursor-atomic [341.005766] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.375s) [341.826193] [083/133] (681s left) syncobj_wait (invalid-signal-one-illegal-handle) [341.879059] Starting subtest: invalid-signal-one-illegal-handle [341.881187] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [342.021319] [084/133] (681s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [342.124090] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [342.748548] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s) [342.955672] [085/133] (680s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [343.055089] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [343.057499] Starting dynamic subtest: pipe-A [343.165374] Dynamic subtest pipe-A: SKIP (0.108s) [343.173883] Starting dynamic subtest: pipe-B [344.387221] Dynamic subtest pipe-B: SKIP (1.221s) [344.396294] Starting dynamic subtest: pipe-C [345.598177] Dynamic subtest pipe-C: SUCCESS (1.215s) [345.606421] Starting dynamic subtest: pipe-D [346.749775] Dynamic subtest pipe-D: SUCCESS (1.151s) [346.752108] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.698s) [347.955873] [086/133] (675s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [348.064633] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [355.499452] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.437s) [355.682946] [087/133] (668s left) gem_pxp (reject-modify-context-protection-off-3) [355.810374] Starting subtest: reject-modify-context-protection-off-3 [355.812980] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s) [355.972064] [088/133] (668s left) syncobj_timeline (wait-all-for-submit-snapshot) [356.031480] Starting subtest: wait-all-for-submit-snapshot [356.111743] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [356.198847] [089/133] (667s left) kms_color (ctm-signed) [356.298088] Starting subtest: ctm-signed [356.300404] Starting dynamic subtest: pipe-A-eDP-1 [358.369508] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.072s) [358.379100] Starting dynamic subtest: pipe-B-eDP-1 [361.271068] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.901s) [361.279610] Starting dynamic subtest: pipe-C-eDP-1 [363.952443] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.680s) [363.961392] Starting dynamic subtest: pipe-D-eDP-1 [366.616175] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s) [366.618596] Subtest ctm-signed: SUCCESS (10.319s) [367.466566] [090/133] (656s left) gem_ccs (suspend-resume) [367.534295] Starting subtest: suspend-resume [367.538745] Subtest suspend-resume: SKIP (0.000s) [367.663219] [091/133] (656s left) kms_writeback (writeback-check-output) [367.760594] Subtest writeback-check-output: SKIP (0.000s) [367.806529] [092/133] (656s left) gem_exec_whisper (basic-normal-all) [367.875902] Starting subtest: basic-normal-all [370.114458] Subtest basic-normal-all: SUCCESS (2.239s) [370.327592] [093/133] (653s left) gem_partial_pwrite_pread (write-snoop) [370.385322] Subtest write-snoop: SKIP (0.000s) [370.468086] [094/133] (653s left) kms_vblank (ts-continuation-modeset-rpm) [370.573976] Starting subtest: ts-continuation-modeset-rpm [370.576304] Starting dynamic subtest: pipe-A-eDP-1 [373.038930] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.465s) [373.053287] Starting dynamic subtest: pipe-D-eDP-1 [375.292087] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.250s) [375.294443] Subtest ts-continuation-modeset-rpm: SUCCESS (4.719s) [376.110509] [095/133] (648s left) kms_frontbuffer_tracking (fbc-stridechange) [376.202452] Starting subtest: fbc-stridechange [379.527365] Subtest fbc-stridechange: SUCCESS (3.327s) [380.710150] [096/133] (643s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [385.873031] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [385.875419] Starting dynamic subtest: pipe-A-eDP-1 [386.652589] Dynamic subtest pipe-A-eDP-1: SKIP (0.777s) [386.661782] Starting dynamic subtest: pipe-B-eDP-1 [387.778969] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s) [387.783327] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.907s) [389.002997] [097/133] (635s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [389.108190] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [389.112214] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [389.229192] [098/133] (635s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [394.276783] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [394.278812] Starting dynamic subtest: pipe-A-eDP-1 [400.891658] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.615s) [400.900415] Starting dynamic subtest: pipe-B-eDP-1 [407.560333] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.664s) [407.562841] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.284s) [408.455325] [099/133] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [408.568415] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [408.572619] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [408.693168] [100/133] (615s left) kms_invalid_mode (bad-vsync-end) [408.784022] Starting subtest: bad-vsync-end [408.786248] Starting dynamic subtest: pipe-A-eDP-1 [409.081891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [409.090567] Starting dynamic subtest: pipe-B-eDP-1 [409.092818] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [409.100810] Starting dynamic subtest: pipe-C-eDP-1 [409.103175] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [409.111096] Starting dynamic subtest: pipe-D-eDP-1 [409.113403] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [409.115665] Subtest bad-vsync-end: SUCCESS (0.303s) [409.899633] [101/133] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [410.001639] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [410.005813] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [410.110773] [102/133] (614s left) gem_ctx_persistence (heartbeat-hang) [410.176273] Starting subtest: heartbeat-hang [410.180591] Subtest heartbeat-hang: SKIP (0.000s) [410.295874] [103/133] (614s left) kms_flip_tiling (flip-change-tiling) [410.395188] Starting subtest: flip-change-tiling [410.397431] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [410.567973] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.174s) [410.579348] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [410.713266] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s) [410.724082] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [410.846333] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [410.857125] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [410.979214] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.131s) [410.993683] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [411.122546] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [411.137148] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [411.267376] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [411.278278] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [411.400559] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [411.411825] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [411.512054] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [411.523241] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [411.657325] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [411.667854] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [411.801256] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [411.812077] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [411.944773] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [411.960649] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [412.090204] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [412.099144] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [412.223076] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [412.234554] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [412.357918] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [412.368766] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [412.468080] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s) [412.476743] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [412.641653] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s) [412.658200] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [412.783487] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [412.794715] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [412.927893] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [412.941160] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [413.073476] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [413.085389] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [413.217774] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [413.228104] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [413.362343] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [413.373692] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [413.512099] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.147s) [413.523582] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [413.655451] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s) [413.666184] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [413.799894] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [413.810543] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [413.944394] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [413.956380] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [414.088740] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [414.101465] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [414.232788] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [414.245726] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [414.377833] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s) [414.392286] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [414.500313] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s) [414.510980] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [414.644452] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s) [414.653526] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [414.788885] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [414.801184] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [414.933377] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.141s) [414.946888] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [415.078095] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [415.088495] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [415.221942] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s) [415.234802] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [415.367058] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s) [415.377769] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [415.516770] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.147s) [415.567534] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [416.754350] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.192s) [416.764716] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [416.888924] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [416.899797] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [417.022090] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [417.033132] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [417.166524] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [417.180658] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [417.320482] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.153s) [417.336200] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [417.464812] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [417.474672] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [417.598794] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [417.608712] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [417.710854] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [417.724852] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [417.855275] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [417.864201] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [417.999093] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [418.008894] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [418.142960] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [418.152987] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [418.287302] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [418.301562] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [418.421778] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.130s) [418.436771] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [418.555713] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [418.566356] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [418.665447] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [418.675359] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [418.799406] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.132s) [418.811273] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [418.942978] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [418.954125] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [419.087437] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [419.098793] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [419.232166] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [419.242239] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [419.377450] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [419.389968] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [419.521312] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [419.532583] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [419.643212] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s) [419.654343] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [419.786874] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s) [419.800601] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [419.931922] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s) [419.945570] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [420.076039] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [420.089067] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [420.220436] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [420.233606] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [420.364875] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [420.375814] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [420.509314] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s) [420.521764] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [420.662555] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.151s) [420.673232] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [420.807709] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [420.819049] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [420.951273] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [420.967702] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [421.095798] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.141s) [421.107513] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [421.239897] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [421.250987] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [421.395437] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.153s) [421.410086] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [421.540650] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s) [421.551613] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [421.663052] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s) [421.714985] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [422.979937] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.272s) [422.990333] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [423.080560] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [423.091091] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [423.180641] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [423.191634] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [423.291488] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [423.305487] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [423.402124] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [423.412516] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [423.513495] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [423.522501] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [423.613206] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [423.624209] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [423.713859] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [423.724809] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [423.813750] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [423.824332] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [423.924524] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [423.934329] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [424.035130] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [424.045519] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [424.135147] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s) [424.145525] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [424.235300] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [424.245870] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [424.336043] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [424.346971] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [424.435364] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [424.445896] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [424.535182] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s) [424.545993] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [424.646122] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s) [424.656205] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [424.757249] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s) [424.767109] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [424.868922] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s) [424.880339] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [424.979897] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.108s) [424.989134] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [425.090934] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [425.101617] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [425.202329] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s) [425.215719] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [425.312878] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s) [425.325520] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [425.424064] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s) [425.435312] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [425.535148] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s) [425.545815] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [425.646629] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [425.659992] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [425.757487] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [425.767692] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [425.907373] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.148s) [425.917256] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [426.018438] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s) [426.028803] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [426.129722] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s) [426.140573] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [426.240625] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [426.251400] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [426.351568] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s) [426.363106] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [426.462841] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [426.473366] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [426.573904] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s) [426.584093] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [426.685506] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s) [426.695943] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [426.796366] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s) [426.838176] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [428.123286] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.292s) [428.134105] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [428.234579] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [428.246030] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [428.334157] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [428.346736] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [428.445272] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.108s) [428.456344] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [428.555992] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [428.566202] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [428.666886] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [428.677425] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [428.767917] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [428.777066] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [428.867551] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [428.877785] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [428.967850] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [428.978229] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [429.066816] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s) [429.074991] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [429.177829] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s) [429.188061] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [429.278298] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s) [429.288646] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [429.377799] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s) [429.387493] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [429.478193] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [429.490442] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [429.578660] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [429.587272] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [429.729468] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.148s) [429.740445] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [429.839020] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.108s) [429.849512] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [429.950345] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s) [429.961649] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [430.061221] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s) [430.074679] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [430.161848] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.097s) [430.173840] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [430.273466] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [430.285045] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [430.384094] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [430.393146] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [430.494240] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [430.504081] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [430.605415] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s) [430.618786] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [430.716520] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s) [430.727108] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [430.827740] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [430.838440] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [430.938881] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [430.949418] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [431.050175] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s) [431.061156] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [431.161630] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s) [431.172558] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [431.273383] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.108s) [431.284486] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [431.382970] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [431.393895] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [431.494108] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [431.506393] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [431.605627] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s) [431.618838] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [431.717030] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s) [431.730416] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [431.866570] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.148s) [431.876092] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [431.977845] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [432.010732] Subtest flip-change-tiling: SUCCESS (21.618s) [433.218785] [104/133] (591s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [433.318522] Starting subtest: fbc-psr2-cursor-mmap-cpu [433.320458] Starting dynamic subtest: eDP-1 [433.324580] Dynamic subtest eDP-1: SKIP (0.000s) [433.328705] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [433.403288] [105/133] (591s left) kms_chamelium_frames (dp-crc-fast) [433.796642] Subtest dp-crc-fast: SKIP (0.000s) [434.608112] [106/133] (590s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [434.706222] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [434.708431] Starting dynamic subtest: pipe-A-eDP-1 [434.728693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s) [434.738455] Starting dynamic subtest: pipe-B-eDP-1 [434.758623] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [434.767063] Starting dynamic subtest: pipe-C-eDP-1 [434.787064] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s) [434.795607] Starting dynamic subtest: pipe-D-eDP-1 [434.816553] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [434.818818] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s) [437.084152] [107/133] (587s left) kms_colorop (plane-xr24-xr24-srgb_inv_eotf_lut) [437.222138] Subtest plane-XR24-XR24-srgb_inv_eotf_lut: SKIP (0.000s) [437.302813] [108/133] (587s left) kms_draw_crc (draw-method-pwrite) [437.399125] Starting subtest: draw-method-pwrite [437.400998] Starting dynamic subtest: xrgb8888-untiled [437.964529] Dynamic subtest xrgb8888-untiled: SUCCESS (0.567s) [437.973141] Starting dynamic subtest: rgb565-untiled [438.397849] Dynamic subtest rgb565-untiled: SUCCESS (0.432s) [438.408380] Starting dynamic subtest: xrgb2101010-untiled [438.942189] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s) [438.950584] Starting dynamic subtest: xbgr16161616f-untiled [439.701837] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s) [439.711178] Starting dynamic subtest: xrgb8888-xtiled [441.419664] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.721s) [441.427921] Starting dynamic subtest: rgb565-xtiled [442.453469] Dynamic subtest rgb565-xtiled: SUCCESS (1.032s) [442.461905] Starting dynamic subtest: xrgb2101010-xtiled [444.175607] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.721s) [444.183831] Starting dynamic subtest: xbgr16161616f-xtiled [447.353689] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.177s) [447.362274] Starting dynamic subtest: xrgb8888-4tiled [448.420182] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.065s) [448.429251] Starting dynamic subtest: rgb565-4tiled [448.976045] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s) [448.984269] Starting dynamic subtest: xrgb2101010-4tiled [450.031706] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.055s) [450.040219] Starting dynamic subtest: xbgr16161616f-4tiled [452.931481] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.899s) [452.933769] Subtest draw-method-pwrite: SUCCESS (15.534s) [453.057941] [109/133] (571s left) gem_exec_params (dr4-dirt) [453.115424] Starting subtest: DR4-dirt [453.117727] Subtest DR4-dirt: SUCCESS (0.000s) [453.235802] [110/133] (571s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [453.335142] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [453.337428] Starting dynamic subtest: pipe-A-default-mode [453.625022] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [453.629919] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.288s) [454.503538] [111/133] (570s left) kms_cursor_crc (cursor-random-64x21) [454.688206] Starting subtest: cursor-random-64x21 [454.740041] Subtest cursor-random-64x21: SKIP (0.045s) [454.997847] [112/133] (569s left) kms_big_fb (y-tiled-64bpp-rotate-270) [455.096852] Starting subtest: y-tiled-64bpp-rotate-270 [455.101301] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [455.206362] [113/133] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [455.307968] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [462.681309] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.378s) [462.837998] [114/133] (562s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [462.929962] Starting subtest: plane-downscale-factor-0-5-with-rotation [462.932287] Starting dynamic subtest: pipe-A [462.951960] Dynamic subtest pipe-A: SKIP (0.019s) [462.959849] Starting dynamic subtest: pipe-B [462.982417] Dynamic subtest pipe-B: SKIP (0.031s) [462.990818] Starting dynamic subtest: pipe-C [463.013568] Dynamic subtest pipe-C: SKIP (0.031s) [463.021652] Starting dynamic subtest: pipe-D [463.047076] Dynamic subtest pipe-D: SKIP (0.032s) [463.051247] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.115s) [463.156461] [115/133] (561s left) kms_concurrent (multi-plane-atomic-lowres) [463.248781] Starting subtest: multi-plane-atomic-lowres [463.250978] Starting dynamic subtest: pipe-A-eDP-1 [463.763824] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.512s) [463.765973] Subtest multi-plane-atomic-lowres: SUCCESS (0.513s) [464.570876] [116/133] (560s left) i915_pm_rpm (sysfs-read) [466.104660] Starting subtest: sysfs-read [467.264236] Subtest sysfs-read: SUCCESS (1.156s) [467.644241] [117/133] (557s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [467.700676] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [467.703108] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [467.809093] [118/133] (557s left) kms_universal_plane (universal-plane-functional) [467.898345] Starting subtest: universal-plane-functional [467.900611] Starting dynamic subtest: pipe-A-eDP-1 [471.839877] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.943s) [471.849040] Starting dynamic subtest: pipe-B-eDP-1 [476.527903] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.684s) [476.536105] Starting dynamic subtest: pipe-C-eDP-1 [480.853189] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.324s) [480.866275] Starting dynamic subtest: pipe-D-eDP-1 [485.268576] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.414s) [485.271058] Subtest universal-plane-functional: SUCCESS (17.372s) [486.161031] [119/133] (539s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [486.221286] Starting subtest: y-tiled-ccs-to-yf-tiled [486.225819] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [486.427409] [120/133] (538s left) kms_psr (psr2-sprite-mmap-cpu) [486.512055] Starting subtest: psr2-sprite-mmap-cpu [486.514380] Starting dynamic subtest: eDP-1 [488.228611] Dynamic subtest eDP-1: SUCCESS (1.718s) [488.231016] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.719s) [489.138101] [121/133] (536s left) kms_pm_lpsp (kms-lpsp) [490.232937] Starting subtest: kms-lpsp [490.235245] Starting dynamic subtest: pipe-A-eDP-1 [490.369032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s) [490.666183] Subtest kms-lpsp: SUCCESS (0.438s) [491.553411] [122/133] (533s left) syncobj_eventfd (invalid-bad-pad) [491.617785] Starting subtest: invalid-bad-pad [491.620195] Subtest invalid-bad-pad: SUCCESS (0.000s) [491.745431] [123/133] (533s left) gem_readwrite (read-bad-handle) [491.802617] Subtest read-bad-handle: SKIP (0.000s) [491.867724] [124/133] (533s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [491.968199] Starting subtest: psr-rgb565-draw-render [499.094413] Subtest psr-rgb565-draw-render: SUCCESS (7.128s) [499.252530] [125/133] (526s left) gem_spin_batch (user-each) [499.320436] Starting subtest: user-each [502.590899] Subtest user-each: SUCCESS (3.262s) [502.997211] [126/133] (522s left) syncobj_basic (bad-destroy-pad) [503.053631] Starting subtest: bad-destroy-pad [503.055997] Subtest bad-destroy-pad: SUCCESS (0.000s) [503.182823] [127/133] (522s left) kms_addfb_basic (basic-y-tiled-legacy) [503.242244] Starting subtest: basic-y-tiled-legacy [503.246757] Subtest basic-y-tiled-legacy: SKIP (0.000s) [503.432639] [128/133] (522s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [503.530158] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [503.532548] Starting dynamic subtest: pipe-A-eDP-1 [503.541685] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [503.551758] Starting dynamic subtest: pipe-B-eDP-1 [503.561543] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [503.569749] Starting dynamic subtest: pipe-C-eDP-1 [503.578627] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [503.586828] Starting dynamic subtest: pipe-D-eDP-1 [503.595533] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [503.599938] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [505.765126] [129/133] (519s left) kms_rotation_crc (primary-rotation-180) [505.856772] Starting subtest: primary-rotation-180 [512.915637] Subtest primary-rotation-180: SUCCESS (7.059s) [514.130069] [130/133] (511s left) prime_vgem (fence-write-hang) [514.209296] Subtest fence-write-hang: SKIP (0.000s) [514.328860] [131/133] (511s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [514.427845] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [514.432174] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [514.563124] [132/133] (511s left) gem_exec_balancer (indices) [514.621114] Starting subtest: indices [516.852333] Subtest indices: SUCCESS (2.229s) [517.173965] [133/133] (508s left) prime_mmap (test_forked_cpu_write) [517.224406] Starting subtest: test_forked_cpu_write [517.226462] Starting dynamic subtest: test_forked_cpu_write-smem [517.233057] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s) [517.235397] Subtest test_forked_cpu_write: SUCCESS (0.012s) [517.363517] 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.