[57.422773] Initializing watchdogs [57.422872] /dev/watchdog0 [57.437252] [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] [57.441651] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.443861] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.447206] [001/131] (960s left) kms_concurrent (multi-plane-atomic-lowres) [57.611037] Starting subtest: multi-plane-atomic-lowres [57.613296] Starting dynamic subtest: pipe-A-eDP-1 [58.137344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.525s) [58.139575] Subtest multi-plane-atomic-lowres: SUCCESS (0.525s) [58.966107] [002/131] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [59.072600] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [59.076977] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [59.164661] [003/131] (958s left) kms_flip (plain-flip-interruptible) [59.270217] Starting subtest: plain-flip-interruptible [59.272645] Starting dynamic subtest: A-eDP1 [60.970483] Dynamic subtest A-eDP1: SUCCESS (1.696s) [60.979244] Starting dynamic subtest: B-eDP1 [62.600937] Dynamic subtest B-eDP1: SUCCESS (1.628s) [62.609355] Starting dynamic subtest: C-eDP1 [64.315054] Dynamic subtest C-eDP1: SUCCESS (1.712s) [64.321679] Starting dynamic subtest: D-eDP1 [65.941220] Dynamic subtest D-eDP1: SUCCESS (1.624s) [65.943722] Subtest plain-flip-interruptible: SUCCESS (6.666s) [67.103439] [004/131] (950s left) gem_exec_params (readonly) [67.168079] Starting subtest: readonly [67.170661] Subtest readonly: SUCCESS (0.002s) [67.302865] [005/131] (950s left) api_intel_allocator (open-vm) [67.361703] Starting subtest: open-vm [67.365903] Subtest open-vm: SUCCESS (0.003s) [67.488204] [006/131] (950s left) kms_psr (fbc-psr2-sprite-blt) [67.591098] Starting subtest: fbc-psr2-sprite-blt [67.593388] Starting dynamic subtest: eDP-1 [67.597479] Dynamic subtest eDP-1: SKIP (0.000s) [67.601539] Subtest fbc-psr2-sprite-blt: SKIP (0.000s) [67.655413] [007/131] (950s left) kms_pm_backlight (bad-brightness) [67.755787] Starting subtest: bad-brightness [67.821132] Starting dynamic subtest: eDP-1 [68.102468] Dynamic subtest eDP-1: SUCCESS (0.282s) [68.105246] Subtest bad-brightness: SUCCESS (0.346s) [68.935893] [008/131] (949s left) kms_cursor_crc (cursor-rapid-movement-256x256) [69.155218] Starting subtest: cursor-rapid-movement-256x256 [69.157500] Starting dynamic subtest: pipe-A-eDP-1 [69.708328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s) [69.737858] Starting dynamic subtest: pipe-D-eDP-1 [70.932590] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.204s) [70.934595] Subtest cursor-rapid-movement-256x256: SUCCESS (1.775s) [71.791795] [009/131] (946s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [71.920066] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [71.924785] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [73.004868] [010/131] (945s left) syncobj_timeline (host-signal-points) [73.064889] Starting subtest: host-signal-points [73.069791] Subtest host-signal-points: SUCCESS (0.004s) [73.155578] [011/131] (945s left) syncobj_wait (invalid-reset-bad-pad) [73.211035] Starting subtest: invalid-reset-bad-pad [73.213343] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [73.290238] [012/131] (945s left) gem_exec_schedule (pi-shared-iova) [73.479169] Starting subtest: pi-shared-iova [73.481450] Starting dynamic subtest: rcs0 [73.545774] Dynamic subtest rcs0: SUCCESS (0.068s) [73.553749] Starting dynamic subtest: vcs0 [73.606571] Dynamic subtest vcs0: SUCCESS (0.061s) [73.613896] Starting dynamic subtest: vcs1 [73.659099] Dynamic subtest vcs1: SUCCESS (0.052s) [73.667278] Starting dynamic subtest: vecs0 [73.710488] Dynamic subtest vecs0: SUCCESS (0.051s) [73.718952] Starting dynamic subtest: ccs0 [73.762325] Dynamic subtest ccs0: SUCCESS (0.052s) [73.764883] Subtest pi-shared-iova: SUCCESS (0.285s) [75.021733] [013/131] (943s left) perf (oa-exponents) [75.131124] Starting subtest: oa-exponents [75.133075] Starting dynamic subtest: 0-rcs0 [76.990704] Dynamic subtest 0-rcs0: SUCCESS (1.859s) [76.998045] Starting dynamic subtest: 1-vcs1 [78.903910] Dynamic subtest 1-vcs1: SUCCESS (1.912s) [78.906876] Subtest oa-exponents: SUCCESS (3.771s) [78.934302] [014/131] (939s left) gem_close (basic) [78.985927] Starting subtest: basic [78.988369] Subtest basic: SUCCESS (0.000s) [79.096034] [015/131] (939s left) kms_flip (plain-flip-ts-check) [79.192837] Starting subtest: plain-flip-ts-check [79.195137] Starting dynamic subtest: A-eDP1 [88.101601] Dynamic subtest A-eDP1: SUCCESS (8.905s) [88.110706] Starting dynamic subtest: B-eDP1 [97.025456] Dynamic subtest B-eDP1: SUCCESS (8.922s) [97.034488] Starting dynamic subtest: C-eDP1 [105.941710] Dynamic subtest C-eDP1: SUCCESS (8.915s) [105.948915] Starting dynamic subtest: D-eDP1 [114.867764] Dynamic subtest D-eDP1: SUCCESS (8.924s) [114.870326] Subtest plain-flip-ts-check: SUCCESS (35.672s) [116.033895] [016/131] (902s left) gem_exec_whisper (basic-fds-all) [116.099491] Starting subtest: basic-fds-all [126.908478] Subtest basic-fds-all: SUCCESS (10.804s) [127.087756] [017/131] (891s left) gem_exec_fence (syncobj-unused-fence) [127.572261] Starting subtest: syncobj-unused-fence [127.579391] Subtest syncobj-unused-fence: SUCCESS (0.007s) [129.054685] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [129.057578] [018/131] (889s left) kms_vblank (ts-continuation-dpms-rpm) [129.165914] Starting subtest: ts-continuation-dpms-rpm [129.168228] Starting dynamic subtest: pipe-A-eDP-1 [131.631097] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.461s) [131.645312] Starting dynamic subtest: pipe-D-eDP-1 [133.867720] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.235s) [133.869797] Subtest ts-continuation-dpms-rpm: SUCCESS (4.699s) [134.661009] [019/131] (883s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [134.762790] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [134.767237] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [134.875227] [020/131] (883s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [135.003073] Starting subtest: basic-busy-flip-before-cursor-varying-size [135.007372] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [135.129064] [021/131] (883s left) gem_workarounds (suspend-resume-context) [135.197756] Starting subtest: suspend-resume-context [151.166866] Subtest suspend-resume-context: SUCCESS (1.214s) [151.293876] [022/131] (882s left) kms_prime (d3hot) [153.482547] Subtest D3hot: SKIP (0.000s) [153.559643] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.amdgpu: true [153.560325] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.xe: true [153.563094] [023/131] (879s left) fbdev (read) [153.604835] Starting subtest: read [154.140867] Subtest read: SUCCESS (0.531s) [154.200468] [024/131] (879s left) kms_psr (psr-basic) [154.297182] Starting subtest: psr-basic [154.299325] Starting dynamic subtest: eDP-1 [155.904364] Dynamic subtest eDP-1: SUCCESS (1.598s) [155.906630] Subtest psr-basic: SUCCESS (1.599s) [156.685662] [025/131] (876s left) kms_big_fb (linear-addfb) [156.791551] Starting subtest: linear-addfb [156.793778] Subtest linear-addfb: SUCCESS (0.000s) [156.906011] [026/131] (876s left) kms_flip (flip-vs-dpms-off-vs-modeset) [157.001320] Starting subtest: flip-vs-dpms-off-vs-modeset [157.003696] Starting dynamic subtest: A-eDP1 [160.594001] Dynamic subtest A-eDP1: SUCCESS (3.580s) [160.608966] Starting dynamic subtest: B-eDP1 [163.772637] Dynamic subtest B-eDP1: SUCCESS (3.171s) [163.783612] Starting dynamic subtest: C-eDP1 [166.862996] Dynamic subtest C-eDP1: SUCCESS (3.086s) [166.872797] Starting dynamic subtest: D-eDP1 [169.926554] Dynamic subtest D-eDP1: SUCCESS (3.059s) [169.929013] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.902s) [170.724038] [027/131] (862s left) gem_softpin (allocator-nopin-reserve) [170.781561] Starting subtest: allocator-nopin-reserve [170.856358] Subtest allocator-nopin-reserve: SUCCESS (0.074s) [170.996198] [028/131] (862s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [171.097730] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [175.764469] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.667s) [175.898445] [029/131] (857s left) gem_basic (create-close) [175.950594] Starting subtest: create-close [175.954577] Subtest create-close: SUCCESS (0.000s) [176.058608] [030/131] (857s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [176.163203] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [180.691750] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.529s) [180.798968] [031/131] (853s left) gem_gpgpu_fill (basic) [180.856322] Starting subtest: basic [180.858576] Starting dynamic subtest: smem [180.861137] Dynamic subtest smem: SUCCESS (0.007s) [180.863616] Subtest basic: SUCCESS (0.007s) [180.990332] [032/131] (852s left) gem_exec_balancer (hog) [181.056820] Starting subtest: hog [181.061335] Subtest hog: SKIP (0.000s) [181.324020] [033/131] (852s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [181.439013] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [186.021318] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.587s) [186.166636] [034/131] (847s left) dmabuf_sync_file (export-wait-after-attach) [186.209891] Starting subtest: export-wait-after-attach [186.212082] Subtest export-wait-after-attach: SUCCESS (0.000s) [186.272354] [035/131] (847s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [186.372363] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [186.376497] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [186.456508] [036/131] (847s left) syncobj_basic (bad-fd-to-handle) [186.509326] Starting subtest: bad-fd-to-handle [186.511624] Subtest bad-fd-to-handle: SUCCESS (0.000s) [186.629485] [037/131] (847s left) gem_close_race (multigpu-basic-process) [186.693168] Starting subtest: multigpu-basic-process [186.697870] Subtest multigpu-basic-process: SKIP (0.000s) [186.925740] [038/131] (847s left) gem_userptr_blits (userfault) [186.985646] Starting subtest: userfault [186.987851] Subtest userfault: SUCCESS (0.006s) [187.136402] [039/131] (847s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [187.198659] Starting subtest: multi-wait-all-for-submit-unsubmitted [187.298350] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [187.373300] [040/131] (846s left) gem_mmap_wc (write-wc-read-gtt) [187.432766] Subtest write-wc-read-gtt: SKIP (0.000s) [187.489794] [041/131] (846s left) i915_hangman (gt-error-state-capture) [187.555638] Starting subtest: gt-error-state-capture [187.558111] Starting dynamic subtest: rcs0 [198.639371] Dynamic subtest rcs0: SUCCESS (11.085s) [198.650579] Starting dynamic subtest: bcs0 [210.670217] Dynamic subtest bcs0: SUCCESS (12.027s) [210.682570] Starting dynamic subtest: vcs0 [222.575462] Dynamic subtest vcs0: SUCCESS (11.900s) [222.587872] Starting dynamic subtest: vcs1 [232.622442] Dynamic subtest vcs1: SUCCESS (10.041s) [232.635244] Starting dynamic subtest: vecs0 [244.590147] Dynamic subtest vecs0: SUCCESS (11.961s) [244.602434] Starting dynamic subtest: ccs0 [255.662739] Dynamic subtest ccs0: SUCCESS (11.073s) [255.665789] Subtest gt-error-state-capture: SUCCESS (68.097s) [255.741038] [042/131] (778s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [255.847556] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [255.851931] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [255.938195] [043/131] (778s left) i915_pm_rpm (gem-idle) [257.878929] Starting subtest: gem-idle [264.081247] Subtest gem-idle: SUCCESS (6.203s) [264.389985] [044/131] (769s left) kms_flip (busy-flip) [265.696434] Starting subtest: busy-flip [265.698840] Starting dynamic subtest: A-eDP1 [267.401754] Dynamic subtest A-eDP1: SUCCESS (1.705s) [267.413016] Starting dynamic subtest: B-eDP1 [269.122524] Dynamic subtest B-eDP1: SUCCESS (1.719s) [269.137383] Starting dynamic subtest: C-eDP1 [270.832520] Dynamic subtest C-eDP1: SUCCESS (1.707s) [270.841580] Starting dynamic subtest: D-eDP1 [272.562542] Dynamic subtest D-eDP1: SUCCESS (1.729s) [272.564969] Subtest busy-flip: SUCCESS (6.870s) [273.722756] [045/131] (760s left) syncobj_wait (invalid-reset-illegal-handle) [273.781548] Starting subtest: invalid-reset-illegal-handle [273.783931] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [273.876008] [046/131] (760s left) core_auth (many-magics) [273.934364] Starting subtest: many-magics [274.747283] Subtest many-magics: SUCCESS (0.816s) [274.819443] [047/131] (759s left) gem_mmap_offset (close-race) [274.891911] Starting subtest: close-race [295.036699] Subtest close-race: SUCCESS (20.142s) [295.138854] [048/131] (739s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [295.206920] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [295.277117] [049/131] (739s left) prime_mmap (test_forked_cpu_write) [295.332858] Starting subtest: test_forked_cpu_write [295.334943] Starting dynamic subtest: test_forked_cpu_write-smem [295.339868] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [295.342150] Subtest test_forked_cpu_write: SUCCESS (0.009s) [295.459987] [050/131] (739s left) kms_vrr (flip-basic) [295.563420] Starting subtest: flip-basic [295.569827] Subtest flip-basic: SKIP (0.000s) [295.631550] [051/131] (738s left) kms_atomic (plane-overlay-legacy) [295.727111] Starting subtest: plane-overlay-legacy [295.729331] Starting dynamic subtest: pipe-A-eDP-1 [296.159142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s) [296.161253] Subtest plane-overlay-legacy: SUCCESS (0.430s) [296.946436] [052/131] (737s left) kms_hdr (static-toggle-suspend) [297.058158] Starting subtest: static-toggle-suspend [297.064588] Subtest static-toggle-suspend: SKIP (0.000s) [297.126503] [053/131] (737s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [297.240526] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [297.244908] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [297.315643] [054/131] (737s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [297.426684] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs [297.429110] Starting dynamic subtest: pipe-A-eDP-1 [297.489103] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [297.500433] Starting dynamic subtest: pipe-B-eDP-1 [297.559663] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [297.569541] Starting dynamic subtest: pipe-C-eDP-1 [297.628298] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [297.638472] Starting dynamic subtest: pipe-D-eDP-1 [297.696481] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [297.700766] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s) [299.588874] [055/131] (735s left) gem_ctx_shared (q-smoketest-all) [299.645539] Starting subtest: Q-smoketest-all [332.074255] Subtest Q-smoketest-all: SUCCESS (32.372s) [333.688974] [056/131] (701s left) kms_plane_alpha_blend (alpha-opaque-fb) [333.788168] Starting subtest: alpha-opaque-fb [334.213906] Starting dynamic subtest: pipe-A-eDP-1 [334.778297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s) [334.788117] Starting dynamic subtest: pipe-D-eDP-1 [336.117215] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s) [336.119959] Subtest alpha-opaque-fb: SUCCESS (2.328s) [336.936787] [057/131] (697s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt) [337.031852] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt [337.036209] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [337.119232] [058/131] (697s left) gem_exec_params (no-blt) [337.175274] Starting subtest: no-blt [337.177546] Subtest no-blt: SUCCESS (0.002s) [337.300262] [059/131] (697s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [337.406177] Starting subtest: bad-rotation-90-y-tiled-ccs [337.408453] Starting dynamic subtest: pipe-A-eDP-1 [337.431115] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [337.441446] Starting dynamic subtest: pipe-B-eDP-1 [337.463301] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [337.472317] Starting dynamic subtest: pipe-C-eDP-1 [337.494609] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [337.504615] Starting dynamic subtest: pipe-D-eDP-1 [337.526890] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [337.531245] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s) [339.588734] [060/131] (695s left) gen9_exec_parse (bb-secure) [339.653935] Subtest bb-secure: SKIP (0.000s) [339.722967] [061/131] (695s left) gem_fenced_exec_thrash (too-many-fences) [339.778730] Subtest too-many-fences: SKIP (0.000s) [339.843167] [062/131] (695s left) kms_lease (lease-unleased-connector) [339.949209] Starting subtest: lease-unleased-connector [339.951562] Starting dynamic subtest: pipe-A-eDP-1 [339.962141] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.011s) [339.972429] Starting dynamic subtest: pipe-B-eDP-1 [339.974687] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [339.985375] Starting dynamic subtest: pipe-C-eDP-1 [339.987758] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [339.998891] Starting dynamic subtest: pipe-D-eDP-1 [340.001223] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [340.003333] Subtest lease-unleased-connector: SUCCESS (0.048s) [340.123394] [063/131] (694s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [340.228146] Starting subtest: y-tiled-addfb-size-offset-overflow [340.232122] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [340.337049] [064/131] (694s left) perf (short-reads) [340.414175] Starting subtest: short-reads [340.432274] Subtest short-reads: SUCCESS (0.018s) [340.474416] [065/131] (694s left) gem_partial_pwrite_pread (reads-snoop) [340.534106] Subtest reads-snoop: SKIP (0.000s) [340.616248] [066/131] (694s left) gem_softpin (evict-active-interruptible) [340.689084] Starting subtest: evict-active-interruptible [340.695788] Subtest evict-active-interruptible: SUCCESS (0.007s) [340.811615] [067/131] (694s left) perf_pmu (event-wait) [340.852229] Starting subtest: event-wait [340.853978] Starting dynamic subtest: rcs0 [340.857979] Dynamic subtest rcs0: SKIP (0.000s) [340.861493] Subtest event-wait: SKIP (0.000s) [340.962768] [068/131] (694s left) kms_psr (fbc-pr-cursor-mmap-cpu) [341.062627] Starting subtest: fbc-pr-cursor-mmap-cpu [341.066268] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s) [341.129976] [069/131] (694s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc) [341.234369] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc [344.218482] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (2.985s) [344.339248] [070/131] (690s left) vgem_basic (setversion) [344.384844] Starting subtest: setversion [344.389139] Subtest setversion: SUCCESS (0.000s) [344.437456] [071/131] (690s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [344.494264] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [344.594511] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.101s) [344.666865] [072/131] (690s left) gem_exec_flush (basic-wb-rw-before-default) [344.731459] Starting subtest: basic-wb-rw-before-default [350.210413] Subtest basic-wb-rw-before-default: SUCCESS (5.477s) [350.394478] [073/131] (685s left) gem_mmap_gtt (cpuset-big-copy) [350.448723] Subtest cpuset-big-copy: SKIP (0.000s) [350.514385] [074/131] (684s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [350.579926] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [350.582392] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [350.688244] [075/131] (684s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [350.801360] Starting subtest: yf-tiled-16bpp-rotate-270 [350.805666] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [350.918274] [076/131] (684s left) gem_eio (in-flight-10ms) [351.165818] Starting subtest: in-flight-10ms [359.821863] Subtest in-flight-10ms: SUCCESS (8.652s) [360.007959] [077/131] (675s left) gem_render_copy (linear) [360.081097] Starting subtest: linear [360.083499] Starting dynamic subtest: smem [360.125234] Dynamic subtest smem: SUCCESS (0.044s) [360.127572] Subtest linear: SUCCESS (0.045s) [360.358287] [078/131] (675s left) gem_exec_capture (capture) [360.422857] Starting subtest: capture [360.425363] Starting dynamic subtest: rcs0-smem [361.255287] Dynamic subtest rcs0-smem: SUCCESS (0.830s) [361.267468] Starting dynamic subtest: bcs0-smem [362.580536] Dynamic subtest bcs0-smem: SUCCESS (1.325s) [362.589922] Starting dynamic subtest: vcs0-smem [363.416948] Dynamic subtest vcs0-smem: SUCCESS (0.836s) [363.426151] Starting dynamic subtest: vcs1-smem [364.740140] Dynamic subtest vcs1-smem: SUCCESS (1.323s) [364.749360] Starting dynamic subtest: vecs0-smem [365.632777] Dynamic subtest vecs0-smem: FAIL (0.830s) [365.643743] Starting dynamic subtest: ccs0-smem [366.898508] Dynamic subtest ccs0-smem: SUCCESS (1.326s) [366.900827] Subtest capture: FAIL (6.473s) [367.023735] [079/131] (668s left) kms_psr (fbc-psr-sprite-blt) [367.140934] Starting subtest: fbc-psr-sprite-blt [367.142873] Starting dynamic subtest: eDP-1 [367.146912] Dynamic subtest eDP-1: SKIP (0.000s) [367.151304] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [367.208922] [080/131] (668s left) kms_addfb_basic (clobberred-modifier) [367.263692] Starting subtest: clobberred-modifier [367.268104] Subtest clobberred-modifier: SKIP (0.000s) [367.415324] [081/131] (668s left) gem_create (hog-create) [367.478365] Starting subtest: hog-create [367.480675] Starting dynamic subtest: smem0 [400.686401] Dynamic subtest smem0: SUCCESS (33.209s) [400.689185] Subtest hog-create: SUCCESS (33.211s) [400.867422] [082/131] (634s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [400.979111] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [400.983440] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [401.062097] [083/131] (634s left) perf_pmu (init-wait) [401.105831] Starting subtest: init-wait [401.108642] Starting dynamic subtest: rcs0 [401.111192] Dynamic subtest rcs0: SUCCESS (0.002s) [401.122834] Starting dynamic subtest: bcs0 [401.125126] Dynamic subtest bcs0: SUCCESS (0.000s) [401.134373] Starting dynamic subtest: vcs0 [401.136653] Dynamic subtest vcs0: SUCCESS (0.001s) [401.145652] Starting dynamic subtest: vcs1 [401.147899] Dynamic subtest vcs1: SUCCESS (0.001s) [401.156904] Starting dynamic subtest: vecs0 [401.159187] Dynamic subtest vecs0: SUCCESS (0.000s) [401.168389] Starting dynamic subtest: ccs0 [401.170301] Dynamic subtest ccs0: SUCCESS (0.000s) [401.172180] Subtest init-wait: SUCCESS (0.008s) [401.217092] [084/131] (634s left) gem_eio (in-flight-1us) [401.440702] Starting subtest: in-flight-1us [409.587662] Subtest in-flight-1us: SUCCESS (8.147s) [409.758177] [085/131] (626s left) gem_exec_schedule (submit-early-slice) [409.838935] Starting subtest: submit-early-slice [409.841379] Starting dynamic subtest: rcs0 [409.872810] Dynamic subtest rcs0: SUCCESS (0.043s) [409.883909] Starting dynamic subtest: bcs0 [409.914807] Dynamic subtest bcs0: SUCCESS (0.041s) [409.926817] Starting dynamic subtest: vcs0 [409.954383] Dynamic subtest vcs0: SUCCESS (0.039s) [409.964279] Starting dynamic subtest: vcs1 [409.994416] Dynamic subtest vcs1: SUCCESS (0.039s) [410.005042] Starting dynamic subtest: vecs0 [410.032892] Dynamic subtest vecs0: SUCCESS (0.038s) [410.042139] Starting dynamic subtest: ccs0 [410.073195] Dynamic subtest ccs0: SUCCESS (0.040s) [410.075519] Subtest submit-early-slice: SUCCESS (0.244s) [411.769656] [086/131] (624s left) kms_invalid_mode (zero-hdisplay) [411.880118] Starting subtest: zero-hdisplay [411.882383] Starting dynamic subtest: pipe-A-eDP-1 [412.174741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [412.185621] Starting dynamic subtest: pipe-B-eDP-1 [412.187929] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [412.197119] Starting dynamic subtest: pipe-C-eDP-1 [412.199643] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [412.209178] Starting dynamic subtest: pipe-D-eDP-1 [412.211619] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [412.213937] Subtest zero-hdisplay: SUCCESS (0.299s) [413.039105] [087/131] (622s left) api_intel_bb (render-ccs) [413.091522] Starting subtest: render-ccs [413.446595] Subtest render-ccs: SUCCESS (0.356s) [413.528909] [088/131] (622s left) gem_tiled_pread_pwrite [413.663927] [089/131] (622s left) syncobj_eventfd (invalid-bad-pad) [413.727856] Starting subtest: invalid-bad-pad [413.730235] Subtest invalid-bad-pad: SUCCESS (0.000s) [413.847167] [090/131] (622s left) gem_ctx_shared (detached-shared-gtt) [413.908919] Starting subtest: detached-shared-gtt [416.061425] Subtest detached-shared-gtt: SUCCESS (2.152s) [416.377870] [091/131] (619s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [421.408613] Starting subtest: fbc-psr2-plane-move-sf-dmg-area [421.410544] Starting dynamic subtest: pipe-A-eDP-1 [422.191866] Dynamic subtest pipe-A-eDP-1: SKIP (0.783s) [422.201512] Starting dynamic subtest: pipe-B-eDP-1 [423.324323] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s) [423.328557] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.919s) [424.506529] [092/131] (611s left) perf (invalid-open-flags) [424.579889] Starting subtest: invalid-open-flags [424.582426] Subtest invalid-open-flags: SUCCESS (0.000s) [424.614940] [093/131] (611s left) gem_spin_batch (legacy) [424.677052] Starting subtest: legacy [424.679486] Starting dynamic subtest: default [427.916237] Dynamic subtest default: SUCCESS (3.233s) [427.925540] Starting dynamic subtest: render [431.150168] Dynamic subtest render: SUCCESS (3.231s) [431.159263] Starting dynamic subtest: bsd [434.387670] Dynamic subtest bsd: SUCCESS (3.233s) [434.398664] Starting dynamic subtest: bsd1 [437.619558] Dynamic subtest bsd1: SUCCESS (3.231s) [437.630930] Starting dynamic subtest: bsd2 [440.857519] Dynamic subtest bsd2: SUCCESS (3.235s) [440.868358] Starting dynamic subtest: blt [444.097403] Dynamic subtest blt: SUCCESS (3.236s) [444.108337] Starting dynamic subtest: vebox [447.332036] Dynamic subtest vebox: SUCCESS (3.233s) [447.334577] Subtest legacy: SUCCESS (22.651s) [447.726288] [094/131] (588s left) gem_pxp (reject-modify-context-protection-on) [447.856155] Starting subtest: reject-modify-context-protection-on [447.858639] Subtest reject-modify-context-protection-on: SUCCESS (0.001s) [447.956703] [095/131] (588s left) kms_flip_tiling (flip-change-tiling) [448.066413] Starting subtest: flip-change-tiling [448.068582] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [448.274146] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.207s) [448.286762] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [448.447706] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.170s) [448.459849] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [448.619409] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.170s) [448.631025] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [448.802853] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.182s) [448.815203] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [449.011871] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.209s) [449.022616] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [449.195587] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.182s) [449.207508] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [449.368098] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.170s) [449.381387] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [449.518924] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.147s) [449.530414] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [449.690080] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.170s) [449.702586] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [449.861304] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.170s) [449.873218] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [450.033115] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.170s) [450.046930] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [450.204929] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.169s) [450.217160] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [450.377259] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.170s) [450.389458] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [450.550169] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.170s) [450.567172] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [450.712501] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.161s) [450.724939] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [450.883650] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s) [450.895954] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [451.055696] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.171s) [451.068195] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [451.227562] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.170s) [451.240357] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [451.399984] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.170s) [451.417026] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [451.571982] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.171s) [451.582358] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [451.755038] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.181s) [451.767688] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [451.904454] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.148s) [451.914359] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [452.094416] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.189s) [452.106280] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [452.266502] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.170s) [452.278630] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [452.438484] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.170s) [452.450828] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [452.612834] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.172s) [452.625554] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [452.785819] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.172s) [452.797555] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [452.962140] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.175s) [452.972795] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [453.116985] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.152s) [453.129321] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [453.289030] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.170s) [453.301328] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [453.460138] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.170s) [453.472028] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [453.632583] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.170s) [453.644264] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [453.815712] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.181s) [453.827073] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [454.000641] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.183s) [454.012590] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [454.185794] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.182s) [454.197607] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [454.343584] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.156s) [454.395769] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [455.668665] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.279s) [455.680412] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [455.841714] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.170s) [455.853612] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [456.013813] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.170s) [456.025850] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [456.200722] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.185s) [456.213260] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [456.370701] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.170s) [456.383435] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [456.574349] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.202s) [456.586726] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [456.746647] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.170s) [456.762024] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [456.909597] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.159s) [456.922099] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [457.092982] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.180s) [457.105295] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [457.283291] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.188s) [457.296020] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [457.466738] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.183s) [457.477309] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [457.638892] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.170s) [457.650930] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [457.812397] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.170s) [457.824813] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [457.984052] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.170s) [458.000801] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [458.134159] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s) [458.146450] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [458.305258] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s) [458.317927] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [458.476491] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.170s) [458.488897] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [458.648431] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.170s) [458.660847] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [458.821037] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.170s) [458.833621] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [458.994383] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.172s) [459.006371] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [459.166010] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.170s) [459.177763] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [459.322248] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.155s) [459.338048] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [459.495036] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.171s) [459.506992] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [459.678029] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.181s) [459.689574] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [459.852735] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.173s) [459.864811] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [460.028256] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.174s) [460.038542] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [460.200357] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.170s) [460.212334] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [460.381827] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.179s) [460.393756] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [460.553852] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.170s) [460.565837] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [460.736801] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.181s) [460.748735] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [460.908189] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.170s) [460.922210] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [461.090935] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.181s) [461.103098] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [461.270017] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.178s) [461.281820] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [461.449161] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.177s) [461.460934] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [461.630998] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.180s) [461.643290] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [461.822506] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.189s) [461.875053] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [463.099521] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.230s) [463.112232] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [463.249799] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.149s) [463.262042] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [463.400623] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.147s) [463.412898] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [463.549434] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.148s) [463.565615] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [463.698382] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.148s) [463.710166] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [463.847631] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.148s) [463.859540] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [463.997703] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.148s) [464.014582] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [464.153421] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.153s) [464.164432] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [464.302971] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s) [464.314324] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [464.460104] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.155s) [464.472299] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [464.608997] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.148s) [464.620034] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [464.758264] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.148s) [464.770352] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [464.908681] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.149s) [464.920207] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [465.063214] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.151s) [465.075987] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [465.212866] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.148s) [465.225137] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [465.361353] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.148s) [465.373463] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [465.510388] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.148s) [465.521670] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [465.663921] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.151s) [465.673612] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [465.815793] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.150s) [465.827310] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [465.966964] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.147s) [465.979348] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [466.116613] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.148s) [466.129472] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [466.265261] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.148s) [466.277861] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [466.419218] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.153s) [466.430875] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [466.568965] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.149s) [466.581360] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [466.720637] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.150s) [466.732754] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [466.871997] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.150s) [466.889282] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [467.025831] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.152s) [467.037544] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [467.181149] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.154s) [467.193669] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [467.331024] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.148s) [467.344097] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [467.480762] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.148s) [467.492427] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [467.629787] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.148s) [467.641692] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [467.779297] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.148s) [467.791497] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [467.940249] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.159s) [467.951706] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [468.090702] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.149s) [468.102212] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [468.250627] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.158s) [468.261165] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [468.411277] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.159s) [468.441874] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [469.724843] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.290s) [469.737248] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [469.875626] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.148s) [469.888041] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [470.025529] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s) [470.037787] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [470.173418] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.148s) [470.184874] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [470.342475] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.168s) [470.354624] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [470.491699] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.148s) [470.503748] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [470.641926] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.148s) [470.654100] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [470.792654] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.148s) [470.805307] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [470.942554] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.148s) [470.954666] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [471.090833] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.148s) [471.103150] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [471.261242] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.169s) [471.273259] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [471.415117] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.152s) [471.427439] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [471.566146] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.148s) [471.578517] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [471.717773] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.149s) [471.730117] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [471.867527] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.147s) [471.881520] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [472.017532] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.148s) [472.030088] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [472.169697] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.151s) [472.180964] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [472.322698] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.152s) [472.335033] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [472.472372] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.148s) [472.483632] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [472.623104] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.148s) [472.633973] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [472.772962] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.148s) [472.785413] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [472.921446] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.148s) [472.933662] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [473.070624] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.148s) [473.082822] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [473.224904] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.152s) [473.235678] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [473.380576] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.154s) [473.393138] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [473.534987] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.153s) [473.546988] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [473.684687] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.148s) [473.695312] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [473.834153] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.148s) [473.846240] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [473.984626] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.148s) [473.996989] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [474.134381] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.148s) [474.145890] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [474.283613] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.148s) [474.295396] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [474.433869] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.149s) [474.444879] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [474.583124] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.148s) [474.594368] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [474.734123] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.149s) [474.746306] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [474.892372] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.156s) [474.904593] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [475.047022] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.153s) [475.068909] Subtest flip-change-tiling: SUCCESS (27.000s) [476.299791] [096/131] (559s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [476.395163] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [476.397300] Starting dynamic subtest: pipe-A-default-mode [476.684525] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [476.689274] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.286s) [477.526099] [097/131] (558s left) kms_sequence (get-busy) [477.616192] Starting subtest: get-busy [477.618527] Starting dynamic subtest: pipe-A-eDP-1 [479.565568] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.947s) [479.576135] Starting dynamic subtest: pipe-B-eDP-1 [482.114201] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.548s) [482.127126] Starting dynamic subtest: pipe-C-eDP-1 [484.722962] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.606s) [484.733394] Starting dynamic subtest: pipe-D-eDP-1 [487.260318] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.534s) [487.262606] Subtest get-busy: SUCCESS (9.640s) [488.138668] [098/131] (548s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu) [488.250184] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu [490.824533] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.578s) [490.946318] [099/131] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [491.054797] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [491.058057] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [491.161192] [100/131] (545s left) kms_chamelium_frames (hdmi-aspect-ratio) [491.546244] Subtest hdmi-aspect-ratio: SKIP (0.000s) [492.359610] [101/131] (544s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [497.341709] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [497.346538] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s) [498.185435] [102/131] (538s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [498.294777] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [499.530104] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.237s) [499.755013] [103/131] (536s left) kms_draw_crc (draw-method-render) [499.860930] Starting subtest: draw-method-render [499.862986] Starting dynamic subtest: xrgb8888-untiled [500.098767] Dynamic subtest xrgb8888-untiled: SUCCESS (0.240s) [500.110714] Starting dynamic subtest: rgb565-untiled [500.332310] Dynamic subtest rgb565-untiled: SUCCESS (0.233s) [500.343029] Starting dynamic subtest: xrgb2101010-untiled [500.542966] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s) [500.552503] Starting dynamic subtest: xbgr16161616f-untiled [500.787525] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s) [500.797037] Starting dynamic subtest: xrgb8888-xtiled [500.920804] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [500.929953] Starting dynamic subtest: rgb565-xtiled [501.031932] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s) [501.042674] Starting dynamic subtest: xrgb2101010-xtiled [501.143095] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [501.153741] Starting dynamic subtest: xbgr16161616f-xtiled [501.298530] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.155s) [501.307704] Starting dynamic subtest: xrgb8888-4tiled [501.421481] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s) [501.430672] Starting dynamic subtest: rgb565-4tiled [501.531908] Dynamic subtest rgb565-4tiled: SUCCESS (0.109s) [501.541229] Starting dynamic subtest: xrgb2101010-4tiled [501.643123] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s) [501.652729] Starting dynamic subtest: xbgr16161616f-4tiled [501.788305] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.145s) [501.790326] Subtest draw-method-render: SUCCESS (1.931s) [501.914412] [104/131] (534s left) gem_ctx_bad_destroy (invalid-pad) [501.967431] Starting subtest: invalid-pad [501.969362] Subtest invalid-pad: SUCCESS (0.000s) [502.036106] [105/131] (534s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt) [502.137055] Starting subtest: fbc-rgb565-draw-mmap-gtt [502.140687] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s) [502.238012] [106/131] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [502.341538] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [502.345166] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [502.430246] [107/131] (534s left) kms_big_fb (x-tiled-addfb) [502.546626] Starting subtest: x-tiled-addfb [502.548565] Subtest x-tiled-addfb: SUCCESS (0.000s) [502.649806] [108/131] (534s left) gem_ctx_persistence (engines-queued) [502.717217] Starting subtest: engines-queued [502.719345] Starting dynamic subtest: rcs0 [502.811301] Dynamic subtest rcs0: SUCCESS (0.094s) [502.822929] Starting dynamic subtest: bcs0 [502.866177] Dynamic subtest bcs0: SUCCESS (0.053s) [502.877223] Starting dynamic subtest: vcs0 [504.687464] Dynamic subtest vcs0: SUCCESS (1.817s) [504.700043] Starting dynamic subtest: vcs1 [506.671165] Dynamic subtest vcs1: SUCCESS (1.981s) [506.683826] Starting dynamic subtest: vecs0 [508.654432] Dynamic subtest vecs0: SUCCESS (1.980s) [508.666701] Starting dynamic subtest: ccs0 [508.838819] Dynamic subtest ccs0: SUCCESS (0.184s) [508.841251] Subtest engines-queued: SUCCESS (6.121s) [508.970872] [109/131] (527s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [509.075547] Starting subtest: sprite-rotation-90-pos-100-0 [509.080348] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [509.146562] [110/131] (527s left) sysfs_heartbeat_interval (invalid) [509.211314] Starting subtest: invalid [509.213772] Starting dynamic subtest: vecs0 [509.216111] Dynamic subtest vecs0: SUCCESS (0.000s) [509.225688] Starting dynamic subtest: ccs0 [509.227967] Dynamic subtest ccs0: SUCCESS (0.000s) [509.237261] Starting dynamic subtest: vcs0 [509.239506] Dynamic subtest vcs0: SUCCESS (0.000s) [509.248590] Starting dynamic subtest: bcs0 [509.250846] Dynamic subtest bcs0: SUCCESS (0.000s) [509.259785] Starting dynamic subtest: rcs0 [509.262091] Dynamic subtest rcs0: SUCCESS (0.000s) [509.271019] Starting dynamic subtest: vcs1 [509.273123] Dynamic subtest vcs1: SUCCESS (0.000s) [509.275132] Subtest invalid: SUCCESS (0.005s) [509.325435] [111/131] (527s left) debugfs_test (read_all_entries) [509.384092] Starting subtest: read_all_entries [509.712545] Subtest read_all_entries: SUCCESS (0.328s) [509.818711] [112/131] (527s left) kms_busy (extended-pageflip-hang-newfb) [509.915912] Starting subtest: extended-pageflip-hang-newfb [509.917980] Starting dynamic subtest: pipe-A [536.478373] Dynamic subtest pipe-A: SUCCESS (26.553s) [536.490387] Starting dynamic subtest: pipe-D [551.469866] Dynamic subtest pipe-D: SUCCESS (14.985s) [551.472563] Subtest extended-pageflip-hang-newfb: SUCCESS (41.543s) [552.340841] [113/131] (484s left) vgem_basic (second-client) [552.387485] Starting subtest: second-client [552.408837] Subtest second-client: SUCCESS (0.022s) [552.465557] [114/131] (484s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [552.571352] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [552.573681] Starting dynamic subtest: pipe-A-default-mode [553.699014] Dynamic subtest pipe-A-default-mode: SKIP (1.120s) [553.703384] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.122s) [553.877243] [115/131] (483s left) syncobj_timeline (wait-delayed-signal) [553.932682] Starting subtest: wait-delayed-signal [554.036052] Subtest wait-delayed-signal: SUCCESS (0.102s) [554.112919] [116/131] (482s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [554.208867] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [554.211221] Starting dynamic subtest: pipe-A [554.293951] Dynamic subtest pipe-A: SUCCESS (0.084s) [554.306737] Starting dynamic subtest: pipe-B [555.391485] Dynamic subtest pipe-B: SUCCESS (1.097s) [555.402998] Starting dynamic subtest: pipe-C [556.495649] Dynamic subtest pipe-C: SUCCESS (1.103s) [556.507662] Starting dynamic subtest: pipe-D [557.622924] Dynamic subtest pipe-D: SUCCESS (1.126s) [557.625297] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.414s) [558.778175] [117/131] (478s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [558.888330] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [558.892880] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [558.988850] [118/131] (478s left) kms_panel_fitting (legacy) [559.087813] Starting subtest: legacy [559.090535] Starting dynamic subtest: pipe-A-eDP-1 [559.700828] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.613s) [559.730770] Starting dynamic subtest: pipe-B-eDP-1 [561.293827] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.572s) [561.322770] Starting dynamic subtest: pipe-C-eDP-1 [562.897900] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.582s) [562.925302] Starting dynamic subtest: pipe-D-eDP-1 [564.523355] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.604s) [564.525617] Subtest legacy: SUCCESS (5.433s) [565.686485] [119/131] (471s left) kms_pm_rpm (modeset-lpsp) [567.830866] Starting subtest: modeset-lpsp [569.285147] Subtest modeset-lpsp: SUCCESS (1.454s) [569.370604] [120/131] (467s left) kms_cursor_crc (cursor-offscreen-64x21) [569.540169] Starting subtest: cursor-offscreen-64x21 [569.581768] Subtest cursor-offscreen-64x21: SKIP (0.036s) [569.834759] [121/131] (467s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [569.950403] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [569.954832] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [570.047664] [122/131] (467s left) kms_psr (psr2-cursor-render) [570.150419] Starting subtest: psr2-cursor-render [570.152734] Starting dynamic subtest: eDP-1 [571.797224] Dynamic subtest eDP-1: SUCCESS (1.648s) [571.799602] Subtest psr2-cursor-render: SUCCESS (1.648s) [572.585837] [123/131] (464s left) kms_addfb_basic (addfb25-x-tiled-legacy) [572.694951] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [572.807381] [124/131] (464s left) kms_chamelium_frames (dp-crc-fast) [573.191980] Subtest dp-crc-fast: SKIP (0.000s) [573.988445] [125/131] (463s left) kms_setmode (invalid-clone-single-crtc-stealing) [574.036374] Starting subtest: invalid-clone-single-crtc-stealing [574.042708] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s) [574.143244] [126/131] (463s left) kms_async_flips (alternate-sync-async-flip) [574.235227] Starting subtest: alternate-sync-async-flip [574.607711] Starting dynamic subtest: pipe-A-eDP-1 [577.399773] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.793s) [577.769955] Starting dynamic subtest: pipe-B-eDP-1 [580.528483] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s) [580.899351] Starting dynamic subtest: pipe-C-eDP-1 [583.656207] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s) [584.020119] Starting dynamic subtest: pipe-D-eDP-1 [586.782978] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s) [586.784961] Subtest alternate-sync-async-flip: SUCCESS (12.546s) [587.942316] [127/131] (449s left) kms_ccs (random-ccs-data-y-tiled-ccs) [588.046213] Starting subtest: random-ccs-data-y-tiled-ccs [588.048538] Starting dynamic subtest: pipe-A-eDP-1 [588.074472] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [588.085927] Starting dynamic subtest: pipe-B-eDP-1 [588.109370] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [588.119097] Starting dynamic subtest: pipe-C-eDP-1 [588.143023] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [588.152401] Starting dynamic subtest: pipe-D-eDP-1 [588.177084] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [588.181213] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s) [590.197297] [128/131] (447s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [590.310682] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [590.314872] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [590.412533] [129/131] (447s left) kms_content_protection (srm) [590.590351] Starting subtest: srm [593.935607] Subtest srm: SKIP (3.342s) [595.106948] [130/131] (442s left) kms_plane_multiple (tiling-y) [595.203227] Starting subtest: tiling-y [595.207579] Subtest tiling-y: SKIP (0.000s) [595.275872] [131/131] (442s left) syncobj_timeline (reset-signaled) [595.329906] Starting subtest: reset-signaled [595.332231] Subtest reset-signaled: SUCCESS (0.000s) [595.412237] Closing watchdogs results: parsing output: 0/ for test: kms_concurrent results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_flip results: parsing output: 3/ for test: gem_exec_params results: parsing output: 4/ for test: api_intel_allocator results: parsing output: 5/ for test: kms_psr results: parsing output: 6/ for test: kms_pm_backlight results: parsing output: 7/ for test: kms_cursor_crc results: parsing output: 8/ for test: kms_ccs results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: gem_exec_schedule results: parsing output: 12/ for test: perf results: parsing output: 13/ for test: gem_close results: parsing output: 14/ for test: kms_flip results: parsing output: 15/ for test: gem_exec_whisper results: parsing output: 16/ for test: gem_exec_fence results: parsing output: 17/ for test: kms_vblank results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_cursor_legacy results: parsing output: 20/ for test: gem_workarounds results: parsing output: 21/ for test: kms_prime results: parsing output: 22/ for test: fbdev results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: gem_softpin results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: gem_basic results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: gem_gpgpu_fill results: parsing output: 31/ for test: gem_exec_balancer results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: dmabuf_sync_file results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: syncobj_basic results: parsing output: 36/ for test: gem_close_race results: parsing output: 37/ for test: gem_userptr_blits results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: gem_mmap_wc results: parsing output: 40/ for test: i915_hangman results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: i915_pm_rpm results: parsing output: 43/ for test: kms_flip results: parsing output: 44/ for test: syncobj_wait results: parsing output: 45/ for test: core_auth results: parsing output: 46/ for test: gem_mmap_offset results: parsing output: 47/ for test: kms_pipe_b_c_ivb results: parsing output: 48/ for test: prime_mmap results: parsing output: 49/ for test: kms_vrr results: parsing output: 50/ for test: kms_atomic results: parsing output: 51/ for test: kms_hdr results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_ccs results: parsing output: 54/ for test: gem_ctx_shared results: parsing output: 55/ for test: kms_plane_alpha_blend results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_exec_params results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: gen9_exec_parse results: parsing output: 60/ for test: gem_fenced_exec_thrash results: parsing output: 61/ for test: kms_lease results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: perf results: parsing output: 64/ for test: gem_partial_pwrite_pread results: parsing output: 65/ for test: gem_softpin results: parsing output: 66/ for test: perf_pmu results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: vgem_basic results: parsing output: 70/ for test: syncobj_timeline results: parsing output: 71/ for test: gem_exec_flush results: parsing output: 72/ for test: gem_mmap_gtt results: parsing output: 73/ for test: syncobj_timeline results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: gem_eio results: parsing output: 76/ for test: gem_render_copy results: parsing output: 77/ for test: gem_exec_capture results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: gem_create results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: perf_pmu results: parsing output: 83/ for test: gem_eio results: parsing output: 84/ for test: gem_exec_schedule results: parsing output: 85/ for test: kms_invalid_mode results: parsing output: 86/ for test: api_intel_bb results: parsing output: 87/ for test: gem_tiled_pread_pwrite results: parsing output: 88/ for test: syncobj_eventfd results: parsing output: 89/ for test: gem_ctx_shared results: parsing output: 90/ for test: kms_psr2_sf results: parsing output: 91/ for test: perf results: parsing output: 92/ for test: gem_spin_batch results: parsing output: 93/ for test: gem_pxp results: parsing output: 94/ for test: kms_flip_tiling results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: kms_sequence results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_chamelium_frames results: parsing output: 100/ for test: kms_psr2_sf results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_draw_crc results: parsing output: 103/ for test: gem_ctx_bad_destroy results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ctx_persistence results: parsing output: 108/ for test: kms_rotation_crc results: parsing output: 109/ for test: sysfs_heartbeat_interval results: parsing output: 110/ for test: debugfs_test results: parsing output: 111/ for test: kms_busy results: parsing output: 112/ for test: vgem_basic results: parsing output: 113/ for test: kms_flip_scaled_crc results: parsing output: 114/ for test: syncobj_timeline results: parsing output: 115/ for test: kms_plane_scaling results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_panel_fitting results: parsing output: 118/ for test: kms_pm_rpm results: parsing output: 119/ for test: kms_cursor_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_psr results: parsing output: 122/ for test: kms_addfb_basic results: parsing output: 123/ for test: kms_chamelium_frames results: parsing output: 124/ for test: kms_setmode results: parsing output: 125/ for test: kms_async_flips results: parsing output: 126/ for test: kms_ccs results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_content_protection results: parsing output: 129/ for test: kms_plane_multiple results: parsing output: 130/ for test: syncobj_timeline Done.