[54.943980] Initializing watchdogs [54.944188] /dev/watchdog0 [54.956957] [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] [54.961138] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [54.963211] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [54.966346] [001/133] (960s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [55.037761] Starting subtest: multi-wait-for-submit-submitted-signaled [55.040026] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [55.160156] [002/133] (960s left) syncobj_wait (wait-for-submit-snapshot) [55.214709] Starting subtest: wait-for-submit-snapshot [55.296412] Subtest wait-for-submit-snapshot: SUCCESS (0.082s) [55.378690] [003/133] (960s left) gem_blits (basic) [55.442235] Starting subtest: basic [57.501944] Subtest basic: SUCCESS (2.075s) [57.618313] [004/133] (957s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [57.721152] Starting subtest: yf-tiled-8bpp-rotate-180 [57.725318] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [57.817475] [005/133] (957s left) kms_async_flips (test-cursor) [57.895674] Starting subtest: test-cursor [57.899959] Subtest test-cursor: SKIP (0.000s) [59.078063] [006/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [59.188762] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [59.193044] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [59.303634] [007/133] (956s left) kms_pm_rpm (pm-caching) [61.044487] Starting subtest: pm-caching [61.050129] Subtest pm-caching: SKIP (0.000s) [61.599502] [008/133] (954s left) gem_exercise_blt (fast-copy-emit) [61.656538] Starting subtest: fast-copy-emit [61.659033] Starting dynamic subtest: linear-smem-smem-emit [61.686638] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.030s) [61.694376] Starting dynamic subtest: xmajor-smem-smem-emit [61.704877] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.018s) [61.711907] Starting dynamic subtest: tile4-smem-smem-emit [61.723465] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.018s) [61.730738] Starting dynamic subtest: tile64-smem-smem-emit [61.741834] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.018s) [61.744054] Subtest fast-copy-emit: SUCCESS (0.086s) [61.894671] [009/133] (953s left) vgem_slow (nohang) [61.993168] Starting subtest: nohang [72.308841] Subtest nohang: SUCCESS (10.338s) [72.386451] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true [72.389605] [010/133] (943s left) kms_content_protection (lic-type-0) [72.533614] Starting subtest: lic-type-0 [72.538294] Subtest lic-type-0: SKIP (0.000s) [72.693703] [011/133] (943s left) kms_feature_discovery (display-3x) [72.794656] Starting subtest: display-3x [72.798809] Subtest display-3x: SKIP (0.000s) [72.890774] [012/133] (942s left) gem_mmap_gtt (cpuset-medium-copy-xy) [72.937681] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [72.992626] [013/133] (942s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [73.113299] Starting subtest: cursorA-vs-flipA-varying-size [84.249084] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.139s) [85.098387] [014/133] (930s left) gen7_exec_parse (load-register-reg) [85.159704] Subtest load-register-reg: SKIP (0.000s) [85.224844] [015/133] (930s left) gem_exec_fence (syncobj-wait) [85.625850] Starting subtest: syncobj-wait [86.982359] Subtest syncobj-wait: SUCCESS (1.355s) [87.371614] [016/133] (928s left) gem_mmap_wc (write-read-distinct) [87.422270] Subtest write-read-distinct: SKIP (0.000s) [87.480582] [017/133] (928s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [87.591336] Starting subtest: psr-rgb101010-draw-mmap-wc [94.604840] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.017s) [94.750764] [018/133] (921s left) kms_joiner (basic-ultra-joiner) [94.857879] Subtest basic-ultra-joiner: SKIP (0.000s) [94.937351] [019/133] (921s left) gem_ctx_isolation (nonpriv-switch) [95.001132] Starting subtest: nonpriv-switch [95.003393] Starting dynamic subtest: rcs0 [95.240929] Dynamic subtest rcs0: SUCCESS (0.240s) [95.250529] Starting dynamic subtest: bcs0 [95.536318] Dynamic subtest bcs0: SUCCESS (0.295s) [95.546767] Starting dynamic subtest: vcs0 [95.838438] Dynamic subtest vcs0: SUCCESS (0.302s) [95.847236] Starting dynamic subtest: vcs1 [97.195378] Dynamic subtest vcs1: SUCCESS (1.356s) [97.206263] Starting dynamic subtest: vecs0 [99.187761] Dynamic subtest vecs0: SUCCESS (1.992s) [99.198077] Starting dynamic subtest: ccs0 [101.226962] Dynamic subtest ccs0: SUCCESS (2.039s) [101.229407] Subtest nonpriv-switch: SUCCESS (6.226s) [101.476288] [020/133] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [101.595298] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [108.107712] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.516s) [108.255282] [021/133] (907s left) kms_cursor_crc (cursor-sliding-128x42) [108.465738] Starting subtest: cursor-sliding-128x42 [108.515988] Subtest cursor-sliding-128x42: SKIP (0.045s) [108.725612] [022/133] (907s left) gem_ctx_bad_destroy (invalid-default-ctx) [108.790947] Starting subtest: invalid-default-ctx [108.793265] Subtest invalid-default-ctx: SUCCESS (0.000s) [108.873944] [023/133] (907s left) kms_psr (fbc-psr-suspend) [108.974089] Starting subtest: fbc-psr-suspend [108.976259] Starting dynamic subtest: eDP-1 [108.980635] Dynamic subtest eDP-1: SKIP (0.000s) [108.985069] Subtest fbc-psr-suspend: SKIP (0.001s) [109.067954] [024/133] (907s left) api_intel_bb (reset-bb) [109.122059] Starting subtest: reset-bb [109.127445] Subtest reset-bb: SUCCESS (0.008s) [109.254759] [025/133] (907s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [109.342332] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [109.345943] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [109.447377] [026/133] (906s left) gem_exec_schedule (u-fairslice-all) [109.508590] Starting subtest: u-fairslice-all [111.568994] Subtest u-fairslice-all: SUCCESS (2.062s) [113.037224] [027/133] (903s left) kms_flip (flip-vs-fences) [113.131155] Starting subtest: flip-vs-fences [113.135167] Subtest flip-vs-fences: SKIP (0.000s) [113.218273] [028/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [113.315453] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [114.271216] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.958s) [114.411089] [029/133] (902s left) gem_exec_capture (capture-recoverable) [114.473212] Starting subtest: capture-recoverable [114.478351] Subtest capture-recoverable: SUCCESS (0.003s) [114.618023] [030/133] (901s left) drm_read (empty-block) [114.754513] Starting subtest: empty-block [115.757757] Subtest empty-block: SUCCESS (1.001s) [115.937373] [031/133] (900s left) kms_rotation_crc (bad-tiling) [116.029999] Starting subtest: bad-tiling [116.034367] Subtest bad-tiling: SKIP (0.001s) [116.112116] [032/133] (900s left) gem_basic (create-close) [116.169157] Starting subtest: create-close [116.173746] Subtest create-close: SUCCESS (0.000s) [116.281532] [033/133] (900s left) kms_plane_multiple (2x-tiling-4) [116.382295] Starting subtest: 2x-tiling-4 [116.386814] Subtest 2x-tiling-4: SKIP (0.000s) [116.475261] [034/133] (900s left) kms_psr (fbc-psr-cursor-mmap-cpu) [116.568193] Starting subtest: fbc-psr-cursor-mmap-cpu [116.570414] Starting dynamic subtest: eDP-1 [116.574848] Dynamic subtest eDP-1: SKIP (0.000s) [116.579384] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [116.652173] [035/133] (900s left) kms_flip (2x-blocking-absolute-wf_vblank) [116.744165] Starting subtest: 2x-blocking-absolute-wf_vblank [116.752318] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s) [116.839079] [036/133] (899s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [116.928291] Starting subtest: multiplane-rotation-cropping-bottom [124.185888] Subtest multiplane-rotation-cropping-bottom: SUCCESS (7.260s) [124.345132] [037/133] (892s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [124.438099] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [124.441474] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [124.552729] [038/133] (892s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [124.646127] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [124.649548] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [124.787571] [039/133] (892s left) kms_ccs (random-ccs-data-y-tiled-ccs) [124.874548] Starting subtest: random-ccs-data-y-tiled-ccs [124.876682] Starting dynamic subtest: pipe-A-eDP-1 [124.898509] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [124.908226] Starting dynamic subtest: pipe-B-eDP-1 [124.927825] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [124.935465] Starting dynamic subtest: pipe-C-eDP-1 [124.954976] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [124.961758] Starting dynamic subtest: pipe-D-eDP-1 [124.981737] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [124.985190] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s) [127.121347] [040/133] (889s left) gem_mmap_gtt (big-copy-xy) [127.178748] Subtest big-copy-XY: SKIP (0.000s) [127.247295] [041/133] (889s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [127.347192] Starting subtest: fbcpsr-farfromfence-mmap-gtt [127.351372] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [127.478834] [042/133] (889s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [127.592476] Starting subtest: fbc-rgb565-draw-pwrite [132.118978] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.530s) [133.304843] [043/133] (883s left) kms_cursor_edge_walk (256x256-top-bottom) [133.396291] Starting subtest: 256x256-top-bottom [133.398566] Starting dynamic subtest: pipe-A-eDP-1 [136.837584] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.439s) [136.845517] Starting dynamic subtest: pipe-D-eDP-1 [139.943734] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.104s) [139.945771] Subtest 256x256-top-bottom: SUCCESS (6.545s) [140.795619] [044/133] (876s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [140.906121] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [157.957115] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.051s) [158.764026] [045/133] (858s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [158.827551] Starting subtest: multi-wait-for-submit-available-submitted-signaled [158.829870] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [158.967255] [046/133] (858s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [159.063254] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [159.065626] Starting dynamic subtest: pipe-A-eDP-1 [159.089193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [159.099518] Starting dynamic subtest: pipe-B-eDP-1 [159.120615] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [159.128276] Starting dynamic subtest: pipe-C-eDP-1 [159.149615] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [159.157203] Starting dynamic subtest: pipe-D-eDP-1 [159.179980] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [159.184532] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s) [161.247266] [047/133] (856s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc) [161.348069] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc [164.947389] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.604s) [166.157502] [048/133] (851s left) gem_exec_schedule (pi-distinct-iova) [166.336599] Starting subtest: pi-distinct-iova [166.338424] Starting dynamic subtest: rcs0 [166.408732] Dynamic subtest rcs0: SUCCESS (0.073s) [166.419727] Starting dynamic subtest: vcs0 [166.467905] Dynamic subtest vcs0: SUCCESS (0.059s) [166.478304] Starting dynamic subtest: vcs1 [166.525662] Dynamic subtest vcs1: SUCCESS (0.057s) [166.533321] Starting dynamic subtest: vecs0 [166.579080] Dynamic subtest vecs0: SUCCESS (0.051s) [166.587314] Starting dynamic subtest: ccs0 [166.645120] Dynamic subtest ccs0: SUCCESS (0.064s) [166.647621] Subtest pi-distinct-iova: SUCCESS (0.311s) [168.002763] [049/133] (849s left) kms_properties (colorop-properties-atomic) [168.095850] Starting subtest: colorop-properties-atomic [168.098705] Starting dynamic subtest: pipe-A-eDP-1 [168.429233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.331s) [168.439051] Starting dynamic subtest: pipe-B-eDP-1 [169.486890] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.059s) [169.496786] Starting dynamic subtest: pipe-C-eDP-1 [170.521219] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.032s) [170.530568] Starting dynamic subtest: pipe-D-eDP-1 [171.549728] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.025s) [171.551872] Subtest colorop-properties-atomic: SUCCESS (3.453s) [172.364784] [050/133] (845s left) kms_setmode (invalid-clone-single-crtc) [172.415991] Starting subtest: invalid-clone-single-crtc [172.422227] Subtest invalid-clone-single-crtc: SKIP (0.000s) [172.535129] [051/133] (844s left) gem_tiled_blits (interruptible) [172.592591] Subtest interruptible: SKIP (0.000s) [172.679780] [052/133] (844s left) gem_mmap_offset (basic-uaf) [172.743624] Starting subtest: basic-uaf [172.745989] Subtest basic-uaf: SUCCESS (0.001s) [172.882548] [053/133] (844s left) gem_spin_batch (engines) [172.931718] Starting subtest: engines [172.934094] Starting dynamic subtest: rcs0 [176.171533] Dynamic subtest rcs0: SUCCESS (3.234s) [176.181781] Starting dynamic subtest: bcs0 [179.407073] Dynamic subtest bcs0: SUCCESS (3.233s) [179.414562] Starting dynamic subtest: vcs0 [182.642821] Dynamic subtest vcs0: SUCCESS (3.233s) [182.650483] Starting dynamic subtest: vcs1 [185.878781] Dynamic subtest vcs1: SUCCESS (3.233s) [185.888255] Starting dynamic subtest: vecs0 [189.116964] Dynamic subtest vecs0: SUCCESS (3.235s) [189.124308] Starting dynamic subtest: ccs0 [192.350917] Dynamic subtest ccs0: SUCCESS (3.232s) [192.353244] Subtest engines: SUCCESS (19.415s) [192.596882] [054/133] (824s left) i915_pm_rps (thresholds-park) [192.659682] Starting subtest: thresholds-park [192.664304] Subtest thresholds-park: SKIP (0.001s) [192.784198] [055/133] (824s left) i915_fb_tiling (basic-x-tiling) [192.837863] Subtest basic-x-tiling: SKIP (0.000s) [192.897924] [056/133] (824s left) prime_busy (hang-wait) [192.958198] Starting subtest: hang-wait [192.960497] Starting dynamic subtest: rcs0 [219.443226] Dynamic subtest rcs0: SUCCESS (26.479s) [219.450994] Starting dynamic subtest: bcs0 [226.534091] Dynamic subtest bcs0: SUCCESS (7.088s) [226.543301] Starting dynamic subtest: vcs0 [233.508903] Dynamic subtest vcs0: SUCCESS (6.972s) [233.516481] Starting dynamic subtest: vcs1 [240.540364] Dynamic subtest vcs1: SUCCESS (7.032s) [240.549770] Starting dynamic subtest: vecs0 [247.518068] Dynamic subtest vecs0: SUCCESS (6.976s) [247.528495] Starting dynamic subtest: ccs0 [261.359769] Dynamic subtest ccs0: SUCCESS (13.835s) [261.361702] Subtest hang-wait: SUCCESS (68.396s) [261.505167] [057/133] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [261.603465] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [261.607901] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [261.701765] [058/133] (755s left) perf (non-zero-reason) [261.835037] Starting subtest: non-zero-reason [261.837289] Starting dynamic subtest: 0-rcs0 [267.112474] Dynamic subtest 0-rcs0: SUCCESS (5.277s) [267.124504] Starting dynamic subtest: 1-vcs1 [270.967215] Dynamic subtest 1-vcs1: SUCCESS (3.854s) [270.969947] Subtest non-zero-reason: SUCCESS (9.132s) [271.009802] [059/133] (746s left) gem_mmap_gtt (basic-small-copy-xy) [271.076109] Subtest basic-small-copy-XY: SKIP (0.000s) [271.139857] [060/133] (746s left) kms_chamelium_hpd (vga-hpd-fast) [271.521214] Subtest vga-hpd-fast: SKIP (0.000s) [272.356233] [061/133] (745s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [272.462420] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [273.443189] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.979s) [273.585924] [062/133] (744s left) device_reset (unbind-cold-reset-rebind) [273.631809] Starting subtest: unbind-cold-reset-rebind [273.636393] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [273.703118] [063/133] (744s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [273.764889] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [273.856673] [064/133] (744s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [273.945703] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [273.947661] Starting dynamic subtest: pipe-A-eDP-1 [274.212484] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.239s) [274.222508] Starting dynamic subtest: pipe-B-eDP-1 [275.424853] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s) [275.433605] Starting dynamic subtest: pipe-C-eDP-1 [276.621069] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s) [276.631548] Starting dynamic subtest: pipe-D-eDP-1 [277.874873] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.249s) [277.877281] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.896s) [279.074417] [065/133] (738s left) prime_self_import (basic-with_one_bo) [279.120685] Starting subtest: basic-with_one_bo [279.143106] Subtest basic-with_one_bo: SUCCESS (0.024s) [279.266444] [066/133] (738s left) kms_big_fb (4-tiled-64bpp-rotate-180) [279.364240] Starting subtest: 4-tiled-64bpp-rotate-180 [280.909351] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.546s) [281.124768] [067/133] (736s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [281.184112] Starting subtest: etime-multi-wait-all-for-submit-submitted [281.289136] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s) [281.377237] [068/133] (736s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [281.465891] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [281.468230] Starting dynamic subtest: A-eDP1 [285.061846] Dynamic subtest A-eDP1: SUCCESS (3.592s) [285.070699] Starting dynamic subtest: B-eDP1 [288.259168] Dynamic subtest B-eDP1: SUCCESS (3.197s) [288.267629] Starting dynamic subtest: C-eDP1 [291.337297] Dynamic subtest C-eDP1: SUCCESS (3.076s) [291.345187] Starting dynamic subtest: D-eDP1 [294.452777] Dynamic subtest D-eDP1: SUCCESS (3.114s) [294.455079] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.986s) [295.280298] [069/133] (722s left) gem_mmap_wc (invalid-flags) [295.338367] Subtest invalid-flags: SKIP (0.000s) [295.411830] [070/133] (722s left) gem_pwrite (basic-self) [295.470712] Subtest basic-self: SKIP (0.000s) [295.537306] [071/133] (722s left) i915_drm_fdinfo (most-busy-check-all) [295.575797] Starting subtest: most-busy-check-all [295.578097] Starting dynamic subtest: rcs0 [295.582652] Dynamic subtest rcs0: SKIP (0.005s) [295.591869] Starting dynamic subtest: bcs0 [295.596339] Dynamic subtest bcs0: SKIP (0.000s) [295.604432] Starting dynamic subtest: vcs0 [295.608833] Dynamic subtest vcs0: SKIP (0.000s) [295.616735] Starting dynamic subtest: vcs1 [295.621225] Dynamic subtest vcs1: SKIP (0.000s) [295.629390] Starting dynamic subtest: vecs0 [295.633790] Dynamic subtest vecs0: SKIP (0.000s) [295.641381] Starting dynamic subtest: ccs0 [295.645799] Dynamic subtest ccs0: SKIP (0.000s) [295.650201] Subtest most-busy-check-all: SKIP (0.010s) [295.686135] [072/133] (722s left) gem_exec_fence (parallel) [295.891533] Starting subtest: parallel [295.893864] Starting dynamic subtest: rcs0 [298.039079] Dynamic subtest rcs0: SUCCESS (2.148s) [298.047857] Starting dynamic subtest: bcs0 [300.190075] Dynamic subtest bcs0: SUCCESS (2.150s) [300.200016] Starting dynamic subtest: vcs0 [302.341071] Dynamic subtest vcs0: SUCCESS (2.150s) [302.349352] Starting dynamic subtest: vcs1 [304.495341] Dynamic subtest vcs1: SUCCESS (2.153s) [304.504403] Starting dynamic subtest: vecs0 [306.651369] Dynamic subtest vecs0: SUCCESS (2.155s) [306.661822] Starting dynamic subtest: ccs0 [308.802793] Dynamic subtest ccs0: SUCCESS (2.151s) [308.804903] Subtest parallel: SUCCESS (12.912s) [310.050387] [073/133] (708s left) perf (unprivileged-single-ctx-counters) [310.149929] Starting subtest: unprivileged-single-ctx-counters [310.154205] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [310.193102] [074/133] (708s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [310.250241] Starting subtest: etime-single-wait-available-unsubmitted [310.354079] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s) [310.452990] [075/133] (707s left) gem_exec_reloc (basic-wc-gtt-noreloc) [310.519621] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [310.608265] [076/133] (707s left) kms_lease (possible-crtcs-filtering) [310.707249] Starting subtest: possible-crtcs-filtering [310.711763] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [310.849337] [077/133] (707s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [310.948928] Starting subtest: extended-pageflip-modeset-hang-oldfb [310.951248] Starting dynamic subtest: pipe-A [318.841378] Dynamic subtest pipe-A: SUCCESS (7.892s) [318.850402] Starting dynamic subtest: pipe-D [327.448500] Dynamic subtest pipe-D: SUCCESS (8.602s) [327.450960] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.499s) [328.313398] [078/133] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [328.419662] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [328.424099] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [328.529631] [079/133] (689s left) syncobj_basic (bad-pad-handle-to-fd) [328.591501] Starting subtest: bad-pad-handle-to-fd [328.593769] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [328.718116] [080/133] (689s left) gem_exec_flush (basic-wb-pro-default) [328.787849] Starting subtest: basic-wb-pro-default [334.237271] Subtest basic-wb-pro-default: SUCCESS (5.451s) [334.431449] [081/133] (684s left) gem_ctx_sseu (mmap-args) [334.490405] Subtest mmap-args: SKIP (0.000s) [334.582507] [082/133] (684s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [334.697754] Starting subtest: nonblocking-modeset-vs-cursor-atomic [336.103212] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.405s) [336.983608] [083/133] (681s left) syncobj_wait (invalid-signal-one-illegal-handle) [337.044843] Starting subtest: invalid-signal-one-illegal-handle [337.047234] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [337.159135] [084/133] (681s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [337.253981] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [337.877257] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.625s) [338.062993] [085/133] (680s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [338.156930] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [338.159231] Starting dynamic subtest: pipe-A [338.266775] Dynamic subtest pipe-A: SKIP (0.106s) [338.275714] Starting dynamic subtest: pipe-B [339.440699] Dynamic subtest pipe-B: SKIP (1.171s) [339.449432] Starting dynamic subtest: pipe-C [340.581138] Dynamic subtest pipe-C: SUCCESS (1.146s) [340.590946] Starting dynamic subtest: pipe-D [341.727625] Dynamic subtest pipe-D: SUCCESS (1.146s) [341.729983] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.573s) [342.936785] [086/133] (675s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [343.025777] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [350.383233] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.359s) [350.528555] [087/133] (668s left) gem_pxp (reject-modify-context-protection-off-3) [350.642540] Starting subtest: reject-modify-context-protection-off-3 [350.644981] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s) [350.757165] [088/133] (668s left) syncobj_timeline (wait-all-for-submit-snapshot) [350.812526] Starting subtest: wait-all-for-submit-snapshot [350.894303] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [350.980945] [089/133] (667s left) kms_color (ctm-signed) [351.080333] Starting subtest: ctm-signed [351.082708] Starting dynamic subtest: pipe-A-eDP-1 [353.220189] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.139s) [353.230346] Starting dynamic subtest: pipe-B-eDP-1 [356.044666] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.823s) [356.053996] Starting dynamic subtest: pipe-C-eDP-1 [358.689463] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.645s) [358.699672] Starting dynamic subtest: pipe-D-eDP-1 [361.341675] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.649s) [361.343875] Subtest ctm-signed: SUCCESS (10.259s) [362.179347] [090/133] (656s left) gem_ccs (suspend-resume) [362.242826] Starting subtest: suspend-resume [362.247211] Subtest suspend-resume: SKIP (0.000s) [362.380971] [091/133] (656s left) kms_writeback (writeback-check-output) [362.465385] Subtest writeback-check-output: SKIP (0.000s) [362.506063] [092/133] (656s left) gem_exec_whisper (basic-normal-all) [362.566531] Starting subtest: basic-normal-all [364.851727] Subtest basic-normal-all: SUCCESS (2.286s) [365.044158] [093/133] (654s left) gem_partial_pwrite_pread (write-snoop) [365.108476] Subtest write-snoop: SKIP (0.000s) [365.199080] [094/133] (653s left) kms_vblank (ts-continuation-modeset-rpm) [365.296793] Starting subtest: ts-continuation-modeset-rpm [365.298639] Starting dynamic subtest: pipe-A-eDP-1 [367.868354] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.571s) [367.881878] Starting dynamic subtest: pipe-D-eDP-1 [370.115509] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.246s) [370.117873] Subtest ts-continuation-modeset-rpm: SUCCESS (4.821s) [370.930970] [095/133] (648s left) kms_frontbuffer_tracking (fbc-stridechange) [371.035567] Starting subtest: fbc-stridechange [374.344625] Subtest fbc-stridechange: SUCCESS (3.311s) [375.538059] [096/133] (643s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [380.612851] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf [380.615207] Starting dynamic subtest: pipe-A-eDP-1 [381.391741] Dynamic subtest pipe-A-eDP-1: SKIP (0.775s) [381.401040] Starting dynamic subtest: pipe-B-eDP-1 [382.530464] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s) [382.534789] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.913s) [383.736163] [097/133] (635s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [383.837750] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [383.842124] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [383.977100] [098/133] (635s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [389.000339] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [389.002681] Starting dynamic subtest: pipe-A-eDP-1 [395.645412] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.643s) [395.655805] Starting dynamic subtest: pipe-B-eDP-1 [402.206908] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.558s) [402.209222] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.205s) [403.107652] [099/133] (616s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [403.221624] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [403.225716] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [403.359776] [100/133] (615s left) kms_invalid_mode (bad-vsync-end) [403.445107] Starting subtest: bad-vsync-end [403.447320] Starting dynamic subtest: pipe-A-eDP-1 [403.744226] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s) [403.753336] Starting dynamic subtest: pipe-B-eDP-1 [403.755268] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [403.762933] Starting dynamic subtest: pipe-C-eDP-1 [403.765274] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [403.773274] Starting dynamic subtest: pipe-D-eDP-1 [403.775457] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [403.777655] Subtest bad-vsync-end: SUCCESS (0.303s) [404.650203] [101/133] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [404.743416] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [404.747789] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [404.886328] [102/133] (614s left) gem_ctx_persistence (heartbeat-hang) [404.946423] Starting subtest: heartbeat-hang [404.950934] Subtest heartbeat-hang: SKIP (0.000s) [405.070223] [103/133] (614s left) kms_flip_tiling (flip-change-tiling) [405.167179] Starting subtest: flip-change-tiling [405.169395] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [405.337862] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.172s) [405.349627] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [405.472264] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [405.483515] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [405.605701] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.130s) [405.616124] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [405.748542] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [405.760114] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [405.892749] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [405.906224] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [406.036926] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [406.050707] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [406.170724] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [406.181701] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [406.282343] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s) [406.293847] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [406.428075] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [406.439910] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [406.570777] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [406.581898] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [406.714697] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [406.729249] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [406.859530] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [406.870797] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [406.993614] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [407.005588] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [407.127658] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [407.137551] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [407.237973] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [407.248285] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [407.371070] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.131s) [407.382746] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [407.515656] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [407.527919] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [407.659467] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [407.671707] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [407.804038] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [407.814272] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [407.948516] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [407.963424] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [408.093235] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.143s) [408.105626] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [408.215078] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s) [408.225135] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [408.359157] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s) [408.374754] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [408.503629] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [408.518233] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [408.648079] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [408.662233] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [408.792509] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [408.806142] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [408.925923] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.131s) [408.937705] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [409.070232] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s) [409.080954] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [409.193494] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s) [409.208373] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [409.337576] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s) [409.349045] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [409.481463] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [409.491918] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [409.625822] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [409.637841] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [409.770730] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [409.785625] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [409.914932] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s) [409.928694] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [410.059577] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s) [410.070897] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [410.181660] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s) [410.232952] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [411.486618] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.259s) [411.498322] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [411.620997] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [411.633197] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [411.754388] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [411.763987] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [411.926311] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.170s) [411.941129] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [412.069366] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.143s) [412.083732] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [412.213299] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [412.228165] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [412.346992] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [412.358627] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [412.458552] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [412.470624] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [412.593321] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [412.605382] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [412.736193] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [412.748627] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [412.891510] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.153s) [412.907155] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [413.036035] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.141s) [413.048085] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [413.169869] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [413.180891] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [413.303907] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [413.314980] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [413.414098] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [413.424084] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [413.547256] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.131s) [413.559348] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [413.691998] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.143s) [413.707088] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [413.836154] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [413.851175] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [413.980457] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.141s) [413.995750] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [414.125387] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [414.137086] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [414.270505] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [414.285383] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [414.391376] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.121s) [414.402955] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [414.535809] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s) [414.549243] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [414.680072] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.143s) [414.693531] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [414.825532] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [414.837534] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [414.968681] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [414.981745] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [415.113317] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [415.126951] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [415.257558] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.141s) [415.271139] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [415.380471] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s) [415.391667] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [415.524516] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [415.535156] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [415.669151] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [415.679305] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [415.813494] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [415.823157] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [415.958446] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [415.969427] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [416.101994] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s) [416.116126] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [416.247315] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s) [416.259164] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [416.369571] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s) [416.422402] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [417.623772] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.209s) [417.635797] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [417.724939] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [417.736628] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [417.823592] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.097s) [417.835106] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [417.936377] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [417.947867] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [418.045580] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [418.057715] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [418.156818] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [418.171242] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [418.268717] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.110s) [418.280800] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [418.368428] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [418.380272] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [418.468533] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [418.485730] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [418.579096] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [418.590741] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [418.689670] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [418.700653] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [418.789646] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s) [418.801159] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [418.889873] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s) [418.900771] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [418.990381] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [419.001669] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [419.090440] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [419.100510] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [419.201559] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [419.213197] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [419.312057] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [419.322390] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [419.423369] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s) [419.432968] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [419.523266] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s) [419.536787] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [419.634658] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [419.644145] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [419.745939] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [419.756785] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [419.856970] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s) [419.868264] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [419.967326] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s) [419.981162] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [420.078572] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.108s) [420.091759] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [420.191074] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s) [420.202644] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [420.300728] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [420.310684] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [420.401208] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.098s) [420.412519] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [420.512161] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s) [420.523355] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [420.623624] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s) [420.634563] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [420.745899] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.120s) [420.755094] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [420.856342] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [420.866715] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [420.967611] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s) [420.978862] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [421.078823] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [421.093537] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [421.201030] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.120s) [421.214747] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [421.323033] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.119s) [421.335461] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [421.435129] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s) [421.474506] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [422.660281] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.191s) [422.672141] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [422.760082] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [422.771659] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [422.860633] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [422.872538] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [422.971491] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [422.981458] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [423.082036] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.108s) [423.093168] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [423.247593] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.164s) [423.258563] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [423.348194] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [423.359055] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [423.448422] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [423.459936] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [423.548096] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [423.559252] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [423.698998] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.148s) [423.710396] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [423.808527] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [423.827272] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [423.919130] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [423.930624] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [424.020220] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [424.032626] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [424.120012] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [424.131681] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [424.219993] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [424.231416] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [424.331054] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [424.343157] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [424.441672] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [424.453190] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [424.552766] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s) [424.564693] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [424.664456] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s) [424.673897] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [424.774887] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [424.788117] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [424.885949] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.108s) [424.895539] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [425.035920] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.148s) [425.048368] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [425.157998] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.119s) [425.171304] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [425.279933] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.119s) [425.290754] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [425.391189] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s) [425.405531] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [425.502641] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.108s) [425.516209] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [425.613391] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [425.624748] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [425.724247] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s) [425.735078] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [425.835453] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s) [425.850555] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [425.947443] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s) [425.959267] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [426.057576] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [426.071244] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [426.157787] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s) [426.169216] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [426.268724] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [426.280321] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [426.379758] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s) [426.390762] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [426.491480] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s) [426.503380] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [426.602569] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [426.635623] Subtest flip-change-tiling: SUCCESS (21.471s) [427.870666] [104/133] (591s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [427.957090] Starting subtest: fbc-psr2-cursor-mmap-cpu [427.959327] Starting dynamic subtest: eDP-1 [427.963416] Dynamic subtest eDP-1: SKIP (0.000s) [427.967476] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s) [428.038998] [105/133] (591s left) kms_chamelium_frames (dp-crc-fast) [428.424203] Subtest dp-crc-fast: SKIP (0.000s) [429.276960] [106/133] (590s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [429.371079] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [429.373414] Starting dynamic subtest: pipe-A-eDP-1 [429.393756] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [429.404088] Starting dynamic subtest: pipe-B-eDP-1 [429.424633] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [429.433670] Starting dynamic subtest: pipe-C-eDP-1 [429.453976] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s) [429.462901] Starting dynamic subtest: pipe-D-eDP-1 [429.483078] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s) [429.485264] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s) [431.766607] [107/133] (587s left) kms_colorop (plane-xr24-xr24-srgb_inv_eotf_lut) [431.907163] Subtest plane-XR24-XR24-srgb_inv_eotf_lut: SKIP (0.000s) [431.998287] [108/133] (587s left) kms_draw_crc (draw-method-pwrite) [432.097328] Starting subtest: draw-method-pwrite [432.099183] Starting dynamic subtest: xrgb8888-untiled [432.630512] Dynamic subtest xrgb8888-untiled: SUCCESS (0.533s) [432.640205] Starting dynamic subtest: rgb565-untiled [433.062673] Dynamic subtest rgb565-untiled: SUCCESS (0.433s) [433.071303] Starting dynamic subtest: xrgb2101010-untiled [433.584876] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.522s) [433.593600] Starting dynamic subtest: xbgr16161616f-untiled [434.296042] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.710s) [434.305334] Starting dynamic subtest: xrgb8888-xtiled [435.962757] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.666s) [435.971960] Starting dynamic subtest: rgb565-xtiled [436.996079] Dynamic subtest rgb565-xtiled: SUCCESS (1.032s) [437.005849] Starting dynamic subtest: xrgb2101010-xtiled [438.651670] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.655s) [438.660356] Starting dynamic subtest: xbgr16161616f-xtiled [441.762965] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.110s) [441.771922] Starting dynamic subtest: xrgb8888-4tiled [442.796394] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.032s) [442.807050] Starting dynamic subtest: rgb565-4tiled [443.329451] Dynamic subtest rgb565-4tiled: SUCCESS (0.533s) [443.338339] Starting dynamic subtest: xrgb2101010-4tiled [444.362753] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.033s) [444.372117] Starting dynamic subtest: xbgr16161616f-4tiled [447.151807] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.788s) [447.154134] Subtest draw-method-pwrite: SUCCESS (15.056s) [447.281549] [109/133] (572s left) gem_exec_params (dr4-dirt) [447.347187] Starting subtest: DR4-dirt [447.349064] Subtest DR4-dirt: SUCCESS (0.000s) [447.472982] [110/133] (572s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [447.568160] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [447.570425] Starting dynamic subtest: pipe-A-default-mode [447.857773] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [447.862468] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.288s) [448.675234] [111/133] (571s left) kms_cursor_crc (cursor-random-64x21) [448.854508] Starting subtest: cursor-random-64x21 [448.900612] Subtest cursor-random-64x21: SKIP (0.040s) [449.154331] [112/133] (570s left) kms_big_fb (y-tiled-64bpp-rotate-270) [449.251446] Starting subtest: y-tiled-64bpp-rotate-270 [449.255483] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [449.348717] [113/133] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [449.435553] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [456.706351] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.273s) [456.861315] [114/133] (563s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [456.960737] Starting subtest: plane-downscale-factor-0-5-with-rotation [456.962999] Starting dynamic subtest: pipe-A [456.983346] Dynamic subtest pipe-A: SKIP (0.017s) [456.994793] Starting dynamic subtest: pipe-B [457.012026] Dynamic subtest pipe-B: SKIP (0.028s) [457.021323] Starting dynamic subtest: pipe-C [457.041670] Dynamic subtest pipe-C: SKIP (0.029s) [457.050372] Starting dynamic subtest: pipe-D [457.070357] Dynamic subtest pipe-D: SKIP (0.029s) [457.074088] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.105s) [457.177788] [115/133] (562s left) kms_concurrent (multi-plane-atomic-lowres) [457.277366] Starting subtest: multi-plane-atomic-lowres [457.279621] Starting dynamic subtest: pipe-A-eDP-1 [457.782537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s) [457.784758] Subtest multi-plane-atomic-lowres: SUCCESS (0.505s) [458.638553] [116/133] (561s left) i915_pm_rpm (sysfs-read) [460.160291] Starting subtest: sysfs-read [461.324883] Subtest sysfs-read: SUCCESS (1.165s) [461.718155] [117/133] (558s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [461.783282] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [461.785400] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [461.910633] [118/133] (558s left) kms_universal_plane (universal-plane-functional) [462.008165] Starting subtest: universal-plane-functional [462.010457] Starting dynamic subtest: pipe-A-eDP-1 [466.033193] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.024s) [466.043044] Starting dynamic subtest: pipe-B-eDP-1 [470.532025] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.497s) [470.541140] Starting dynamic subtest: pipe-C-eDP-1 [474.883519] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.349s) [474.892413] Starting dynamic subtest: pipe-D-eDP-1 [479.221056] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.336s) [479.223348] Subtest universal-plane-functional: SUCCESS (17.213s) [480.076251] [119/133] (540s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [480.126844] Starting subtest: y-tiled-ccs-to-yf-tiled [480.131413] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [480.319556] [120/133] (539s left) kms_psr (psr2-sprite-mmap-cpu) [480.410911] Starting subtest: psr2-sprite-mmap-cpu [480.413058] Starting dynamic subtest: eDP-1 [482.152418] Dynamic subtest eDP-1: SUCCESS (1.741s) [482.154718] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.742s) [483.044460] [121/133] (537s left) kms_pm_lpsp (kms-lpsp) [484.140698] Starting subtest: kms-lpsp [484.143300] Starting dynamic subtest: pipe-A-eDP-1 [484.280722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s) [484.588136] Subtest kms-lpsp: SUCCESS (0.448s) [485.482312] [122/133] (534s left) syncobj_eventfd (invalid-bad-pad) [485.537561] Starting subtest: invalid-bad-pad [485.539768] Subtest invalid-bad-pad: SUCCESS (0.000s) [485.670248] [123/133] (534s left) gem_readwrite (read-bad-handle) [485.732267] Subtest read-bad-handle: SKIP (0.000s) [485.793508] [124/133] (534s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [485.897442] Starting subtest: psr-rgb565-draw-render [492.887976] Subtest psr-rgb565-draw-render: SUCCESS (6.991s) [493.033902] [125/133] (527s left) gem_spin_batch (user-each) [493.085622] Starting subtest: user-each [496.442684] Subtest user-each: SUCCESS (3.356s) [496.979069] [126/133] (523s left) syncobj_basic (bad-destroy-pad) [497.028093] Starting subtest: bad-destroy-pad [497.030408] Subtest bad-destroy-pad: SUCCESS (0.000s) [497.118894] [127/133] (523s left) kms_addfb_basic (basic-y-tiled-legacy) [497.164714] Starting subtest: basic-y-tiled-legacy [497.168896] Subtest basic-y-tiled-legacy: SKIP (0.000s) [497.327935] [128/133] (523s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [497.431645] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [497.433997] Starting dynamic subtest: pipe-A-eDP-1 [497.442875] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [497.453566] Starting dynamic subtest: pipe-B-eDP-1 [497.462342] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [497.470729] Starting dynamic subtest: pipe-C-eDP-1 [497.479148] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [497.487381] Starting dynamic subtest: pipe-D-eDP-1 [497.495770] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [497.499801] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [499.706699] [129/133] (520s left) kms_rotation_crc (primary-rotation-180) [499.804369] Starting subtest: primary-rotation-180 [506.773037] Subtest primary-rotation-180: SUCCESS (6.971s) [507.964091] [130/133] (512s left) prime_vgem (fence-write-hang) [508.040236] Subtest fence-write-hang: SKIP (0.000s) [508.152405] [131/133] (512s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [508.252641] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [508.256820] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [508.376920] [132/133] (512s left) gem_exec_balancer (indices) [508.439305] Starting subtest: indices [510.899035] Subtest indices: SUCCESS (2.460s) [511.232116] [133/133] (509s left) prime_mmap (test_forked_cpu_write) [511.293651] Starting subtest: test_forked_cpu_write [511.295957] Starting dynamic subtest: test_forked_cpu_write-smem [511.301805] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s) [511.304090] Subtest test_forked_cpu_write: SUCCESS (0.007s) [511.414277] 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.