[60.797720] Initializing watchdogs [60.797770] /dev/watchdog0 [60.813609] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [60.818567] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.820922] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.822916] [001/155] (960s left) syncobj_wait (single-wait-all-for-submit-signaled) [60.879845] Starting subtest: single-wait-all-for-submit-signaled [60.881378] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [60.972239] [002/155] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [61.064419] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [68.570908] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.498s) [68.677105] [003/155] (952s left) gem_ctx_persistence (userptr) [68.728373] Starting subtest: userptr [68.908762] Subtest userptr: SUCCESS (0.180s) [68.978176] [004/155] (952s left) gem_close_race (basic-process) [69.042133] Starting subtest: basic-process [69.083823] Subtest basic-process: SUCCESS (0.041s) [69.261555] [005/155] (952s left) kms_vrr (seamless-rr-switch-vrr) [69.353039] Starting subtest: seamless-rr-switch-vrr [69.355604] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [69.415734] [006/155] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt) [69.507566] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt [69.509329] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [69.591540] [007/155] (951s left) vgem_basic (dmabuf-mmap) [69.651363] Starting subtest: dmabuf-mmap [69.659545] Subtest dmabuf-mmap: SUCCESS (0.009s) [69.712787] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true [69.714562] [008/155] (951s left) kms_atomic (crtc-invalid-params-fence) [69.799023] Starting subtest: crtc-invalid-params-fence [69.800074] Starting dynamic subtest: pipe-A-eDP-1 [70.230405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.430s) [70.231245] Subtest crtc-invalid-params-fence: SUCCESS (0.431s) [71.052686] [009/155] (950s left) kms_cursor_crc (cursor-random-64x64) [71.225231] Starting subtest: cursor-random-64x64 [71.228603] Starting dynamic subtest: pipe-A-eDP-1 [74.661229] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s) [74.693592] Starting dynamic subtest: pipe-D-eDP-1 [78.684047] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.996s) [78.684997] Subtest cursor-random-64x64: SUCCESS (7.458s) [79.529665] [010/155] (942s left) kms_chamelium_color (ctm-blue-to-red) [79.631291] Subtest ctm-blue-to-red: SKIP (0.000s) [79.669518] [011/155] (941s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [79.756295] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [79.758284] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [80.856025] [012/155] (940s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [80.955981] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite [80.957923] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [81.036739] [013/155] (940s left) gem_eio (in-flight-1us) [81.260537] Starting subtest: in-flight-1us [90.108378] Subtest in-flight-1us: SUCCESS (8.847s) [90.236072] [014/155] (931s left) gem_exec_params (no-bsd) [90.293246] Starting subtest: no-bsd [90.294572] Subtest no-bsd: SUCCESS (0.002s) [92.395601] [015/155] (929s left) gem_exec_schedule (pi-common) [92.593435] Starting subtest: pi-common [92.594261] Starting dynamic subtest: rcs0 [92.605734] Dynamic subtest rcs0: SUCCESS (0.027s) [92.612797] Starting dynamic subtest: bcs0 [92.633148] Dynamic subtest bcs0: SUCCESS (0.027s) [92.643614] Starting dynamic subtest: vcs0 [92.659122] Dynamic subtest vcs0: SUCCESS (0.026s) [92.671343] Starting dynamic subtest: vcs1 [92.685752] Dynamic subtest vcs1: SUCCESS (0.026s) [92.692336] Starting dynamic subtest: vecs0 [92.716916] Dynamic subtest vecs0: SUCCESS (0.031s) [92.723891] Starting dynamic subtest: ccs0 [92.747655] Dynamic subtest ccs0: SUCCESS (0.030s) [92.748519] Subtest pi-common: SUCCESS (0.169s) [92.982538] [016/155] (928s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [93.068776] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [93.069804] Starting dynamic subtest: pipe-A-eDP-1 [93.078881] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [93.086670] Starting dynamic subtest: pipe-B-eDP-1 [93.095263] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [93.102578] Starting dynamic subtest: pipe-C-eDP-1 [93.110760] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [93.117436] Starting dynamic subtest: pipe-D-eDP-1 [93.126877] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [93.128926] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s) [95.335958] [017/155] (926s left) kms_pm_dc (dc3co-vpb-simulation) [96.430128] Starting subtest: dc3co-vpb-simulation [105.305481] Subtest dc3co-vpb-simulation: SKIP (8.828s) [105.365936] [018/155] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [105.452156] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [105.453830] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [105.545351] [019/155] (916s left) gem_tiled_partial_pwrite_pread (writes) [105.593529] Subtest writes: SKIP (0.000s) [105.662107] [020/155] (916s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt) [105.752170] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt [105.754429] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [105.826244] [021/155] (916s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt) [105.923260] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt [105.924933] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [106.015044] [022/155] (915s left) kms_feature_discovery (display-2x) [106.102477] Starting subtest: display-2x [106.104417] Subtest display-2x: SKIP (0.000s) [106.171777] [023/155] (915s left) gem_tiled_swapping (non-threaded) [106.227870] Subtest non-threaded: SKIP (0.000s) [106.312392] [024/155] (915s left) kms_color (ctm-0-25) [106.402363] Starting subtest: ctm-0-25 [106.403496] Starting dynamic subtest: pipe-A-eDP-1 [109.965483] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.563s) [109.973485] Starting dynamic subtest: pipe-B-eDP-1 [114.251683] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.285s) [114.259191] Starting dynamic subtest: pipe-C-eDP-1 [118.388949] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.135s) [118.396827] Starting dynamic subtest: pipe-D-eDP-1 [122.390952] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.002s) [122.392256] Subtest ctm-0-25: SUCCESS (15.988s) [123.206018] [025/155] (898s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [123.309325] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [123.311198] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [123.395580] [026/155] (898s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [123.481185] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [123.482856] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [123.566366] [027/155] (898s left) gem_exec_schedule (wide) [123.748922] Starting subtest: wide [123.754511] Starting dynamic subtest: rcs0 [134.230101] Dynamic subtest rcs0: SUCCESS (10.448s) [134.238493] Starting dynamic subtest: vcs0 [146.623819] Dynamic subtest vcs0: SUCCESS (12.429s) [146.633681] Starting dynamic subtest: vcs1 [159.265640] Dynamic subtest vcs1: SUCCESS (12.640s) [159.275640] Starting dynamic subtest: vecs0 [170.613784] Dynamic subtest vecs0: SUCCESS (11.347s) [170.624278] Starting dynamic subtest: ccs0 [185.904249] Dynamic subtest ccs0: SUCCESS (15.289s) [185.905324] Subtest wide: SUCCESS (62.157s) [187.363071] [028/155] (834s left) kms_plane_alpha_blend (coverage-7efc) [187.458350] Starting subtest: coverage-7efc [187.760511] Starting dynamic subtest: pipe-A-eDP-1 [188.369456] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s) [188.397470] Starting dynamic subtest: pipe-D-eDP-1 [189.743802] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s) [189.744794] Subtest coverage-7efc: SUCCESS (2.286s) [190.572641] [029/155] (831s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy) [190.661182] Starting subtest: fbcpsrhdr-modesetfrombusy [190.662793] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s) [190.773860] [030/155] (831s left) gem_render_copy (yf-tiled) [190.827040] Starting subtest: yf-tiled [190.828996] Subtest yf-tiled: SKIP (0.000s) [191.009938] [031/155] (831s left) kms_cursor_legacy (single-move) [191.130611] Starting subtest: single-move [191.131605] Starting dynamic subtest: pipe-A [196.556248] Dynamic subtest pipe-A: SUCCESS (5.378s) [196.566021] Starting dynamic subtest: pipe-B [201.938458] Dynamic subtest pipe-B: SUCCESS (5.380s) [201.947948] Starting dynamic subtest: pipe-C [207.319767] Dynamic subtest pipe-C: SUCCESS (5.379s) [207.329625] Starting dynamic subtest: pipe-D [212.702257] Dynamic subtest pipe-D: SUCCESS (5.379s) [212.711691] Starting dynamic subtest: all-pipes [218.091069] Dynamic subtest all-pipes: SUCCESS (5.387s) [218.091950] Subtest single-move: SUCCESS (26.913s) [218.185837] [032/155] (804s left) gem_render_copy_redux (flink-interruptible) [218.231400] Starting subtest: flink-interruptible [219.001943] Subtest flink-interruptible: SUCCESS (0.770s) [219.120540] [033/155] (803s left) gem_eio (banned) [219.359554] Starting subtest: banned [219.997324] Subtest banned: SUCCESS (0.646s) [220.146139] [034/155] (802s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [220.240399] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [220.242208] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [220.340514] [035/155] (802s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [220.429075] Starting subtest: fbc-rgb565-draw-mmap-cpu [224.570245] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.142s) [225.773437] [036/155] (796s left) gem_barrier_race (remote-request) [225.817513] Starting subtest: remote-request [225.818450] Starting dynamic subtest: rcs0 [230.995472] Dynamic subtest rcs0: SUCCESS (5.177s) [230.996679] Subtest remote-request: SUCCESS (5.178s) [231.119179] [037/155] (791s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [231.212391] Starting subtest: ccs-on-another-bo-y-tiled-ccs [231.213503] Starting dynamic subtest: pipe-A-eDP-1 [231.223784] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [231.232614] Starting dynamic subtest: pipe-B-eDP-1 [231.241598] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [231.249029] Starting dynamic subtest: pipe-C-eDP-1 [231.257210] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [231.264209] Starting dynamic subtest: pipe-D-eDP-1 [231.272650] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [231.274441] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [233.544094] [038/155] (789s left) gem_mmap_offset (bad-flags) [233.601834] Starting subtest: bad-flags [233.602925] Subtest bad-flags: SUCCESS (0.000s) [233.697912] [039/155] (788s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [233.787361] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [241.668145] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.883s) [241.811761] [040/155] (780s left) kms_atomic_interruptible (legacy-dpms) [241.910396] Starting subtest: legacy-dpms [241.911331] Starting dynamic subtest: pipe-A-eDP-1 [249.328607] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.416s) [249.329579] Subtest legacy-dpms: SUCCESS (7.418s) [250.139095] [041/155] (772s left) kms_psr (fbc-pr-cursor-blt) [250.247905] Starting subtest: fbc-pr-cursor-blt [250.249477] Subtest fbc-pr-cursor-blt: SKIP (0.000s) [250.306322] [042/155] (772s left) gem_request_retire (retire-vma-not-inactive) [250.355165] Starting subtest: retire-vma-not-inactive [250.413913] Subtest retire-vma-not-inactive: SUCCESS (0.057s) [250.525120] [043/155] (772s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-msflip-blt) [250.620425] Starting subtest: hdr-2p-primscrn-indfb-msflip-blt [250.622090] Subtest hdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [250.714886] [044/155] (772s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs) [250.796268] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs [250.797106] Starting dynamic subtest: pipe-A-eDP-1 [250.800690] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [250.808148] Starting dynamic subtest: pipe-B-eDP-1 [250.811463] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [250.818758] Starting dynamic subtest: pipe-C-eDP-1 [250.822422] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [250.829705] Starting dynamic subtest: pipe-D-eDP-1 [250.833156] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [250.834871] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s) [253.097681] [045/155] (769s left) kms_psr (fbc-psr-cursor-mmap-cpu) [253.184768] Starting subtest: fbc-psr-cursor-mmap-cpu [253.185666] Starting dynamic subtest: eDP-1 [253.187405] Dynamic subtest eDP-1: SKIP (0.000s) [253.189157] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [253.253447] [046/155] (769s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [253.345762] Starting subtest: fbcpsr-tiling-y [253.347586] Subtest fbcpsr-tiling-y: SKIP (0.000s) [253.442149] [047/155] (769s left) gem_spin_batch (legacy-resubmit) [253.491451] Starting subtest: legacy-resubmit [253.492513] Starting dynamic subtest: default [253.499655] Dynamic subtest default: SUCCESS (0.008s) [253.509423] Starting dynamic subtest: render [253.510353] Dynamic subtest render: SUCCESS (0.001s) [253.518522] Starting dynamic subtest: bsd [253.519352] Dynamic subtest bsd: SUCCESS (0.003s) [253.526464] Starting dynamic subtest: bsd1 [253.527409] Dynamic subtest bsd1: SUCCESS (0.003s) [253.534435] Starting dynamic subtest: bsd2 [253.535270] Dynamic subtest bsd2: SUCCESS (0.001s) [253.542485] Starting dynamic subtest: blt [253.543523] Dynamic subtest blt: SUCCESS (0.002s) [253.550419] Starting dynamic subtest: vebox [253.551330] Dynamic subtest vebox: SUCCESS (0.003s) [253.552168] Subtest legacy-resubmit: SUCCESS (0.028s) [253.751851] [048/155] (769s left) gem_exec_reloc (basic-gtt-wc-noreloc) [253.806161] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [253.898705] [049/155] (769s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [253.984364] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu [253.986107] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [254.083163] [050/155] (768s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [254.126211] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [254.233403] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s) [254.304525] [051/155] (768s left) gem_exec_balancer (full) [254.368618] Starting subtest: full [259.266435] Subtest full: SUCCESS (4.899s) [259.580181] [052/155] (763s left) kms_frontbuffer_tracking (psr-slowdraw) [259.679650] Starting subtest: psr-slowdraw [285.081778] Subtest psr-slowdraw: SUCCESS (25.403s) [285.190396] [053/155] (737s left) syncobj_timeline (wait-for-submit-complex) [285.233356] Starting subtest: wait-for-submit-complex [285.294669] Subtest wait-for-submit-complex: SUCCESS (0.062s) [285.367443] [054/155] (737s left) api_intel_allocator (reopen) [285.412166] Starting subtest: reopen [285.415350] Subtest reopen: SUCCESS (0.004s) [285.538968] [055/155] (737s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [285.634880] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [285.636665] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [285.724335] [056/155] (737s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [285.819952] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [286.712378] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.893s) [286.869861] [057/155] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [286.971876] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [293.965381] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.994s) [294.109836] [058/155] (729s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [294.205434] Starting subtest: extended-pageflip-modeset-hang-oldfb [294.206405] Starting dynamic subtest: pipe-A [302.119516] Dynamic subtest pipe-A: SUCCESS (7.912s) [302.128588] Starting dynamic subtest: pipe-D [310.733609] Dynamic subtest pipe-D: SUCCESS (8.612s) [310.734636] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.529s) [311.568867] [059/155] (711s left) gem_reg_read (bad-register) [311.616060] Starting subtest: bad-register [311.617084] Subtest bad-register: SUCCESS (0.000s) [311.696943] [060/155] (711s left) kms_joiner (invalid-modeset-ultra-joiner) [311.780637] Starting subtest: invalid-modeset-ultra-joiner [311.782416] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [311.848561] [061/155] (711s left) syncobj_wait (single-wait-all-for-submit-submitted) [311.907298] Starting subtest: single-wait-all-for-submit-submitted [312.008824] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.101s) [312.081848] [062/155] (711s left) perf (invalid-create-userspace-config) [312.175645] Starting subtest: invalid-create-userspace-config [312.179109] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [312.213170] [063/155] (711s left) kms_flip (2x-flip-vs-suspend-interruptible) [312.299658] Starting subtest: 2x-flip-vs-suspend-interruptible [312.302489] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s) [312.403869] [064/155] (711s left) kms_psr (fbc-pr-sprite-plane-onoff) [312.488227] Starting subtest: fbc-pr-sprite-plane-onoff [312.489824] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [312.568285] [065/155] (710s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [312.662094] Starting subtest: 2x-wf_vblank-ts-check-interruptible [312.675340] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.012s) [312.746535] [066/155] (710s left) gem_exec_schedule (semaphore-noskip) [312.807344] Starting subtest: semaphore-noskip [313.256713] Subtest semaphore-noskip: SUCCESS (0.440s) [313.580390] [067/155] (709s left) gem_mmap (bad-offset) [313.632924] Subtest bad-offset: SKIP (0.000s) [313.684483] [068/155] (709s left) gem_ctx_shared (exec-single-timeline) [313.736254] Starting subtest: exec-single-timeline [313.737121] Starting dynamic subtest: rcs0 [314.817489] Dynamic subtest rcs0: SUCCESS (1.071s) [314.829924] Starting dynamic subtest: bcs0 [315.842158] Dynamic subtest bcs0: SUCCESS (1.021s) [315.853068] Starting dynamic subtest: vcs0 [316.930602] Dynamic subtest vcs0: SUCCESS (1.085s) [316.940089] Starting dynamic subtest: vcs1 [318.018240] Dynamic subtest vcs1: SUCCESS (1.085s) [318.029910] Starting dynamic subtest: vecs0 [319.106683] Dynamic subtest vecs0: SUCCESS (1.085s) [319.117840] Starting dynamic subtest: ccs0 [320.194966] Dynamic subtest ccs0: SUCCESS (1.085s) [320.196370] Subtest exec-single-timeline: SUCCESS (6.451s) [320.371153] [069/155] (703s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [320.461663] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [328.023824] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.562s) [328.154847] [070/155] (695s left) syncobj_basic (bad-fd-to-handle) [328.201495] Starting subtest: bad-fd-to-handle [328.202596] Subtest bad-fd-to-handle: SUCCESS (0.000s) [328.308986] [071/155] (695s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt) [328.403583] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt [328.405322] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [328.494407] [072/155] (695s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render) [328.593056] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render [328.594970] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [328.708079] [073/155] (695s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [328.793824] Starting subtest: psr-2p-scndscrn-cur-indfb-move [328.795425] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [328.893177] [074/155] (694s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt) [328.989075] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt [328.990747] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [329.086601] [075/155] (694s left) kms_flip (2x-flip-vs-panning) [329.168203] Starting subtest: 2x-flip-vs-panning [329.179167] Subtest 2x-flip-vs-panning: SKIP (0.011s) [329.256428] [076/155] (694s left) gem_mmap_wc (read) [329.304486] Subtest read: SKIP (0.000s) [329.361295] [077/155] (694s left) kms_plane_scaling (planes-downscale-factor-0-5) [329.453288] Starting subtest: planes-downscale-factor-0-5 [329.454279] Starting dynamic subtest: pipe-A [329.474250] Dynamic subtest pipe-A: SKIP (0.019s) [329.484386] Starting dynamic subtest: pipe-B [329.508241] Dynamic subtest pipe-B: SKIP (0.032s) [329.516191] Starting dynamic subtest: pipe-C [329.539694] Dynamic subtest pipe-C: SKIP (0.032s) [329.547699] Starting dynamic subtest: pipe-D [329.575181] Dynamic subtest pipe-D: SKIP (0.035s) [329.576864] Subtest planes-downscale-factor-0-5: SKIP (0.121s) [329.676527] [078/155] (694s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [329.771427] Starting subtest: psr-rgb101010-draw-blt [337.275493] Subtest psr-rgb101010-draw-blt: SUCCESS (7.505s) [337.394564] [079/155] (686s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-move) [337.489186] Starting subtest: fbchdr-1p-primscrn-cur-indfb-move [337.491525] Subtest fbchdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [337.596121] [080/155] (686s left) gem_exec_schedule (implicit-boths) [337.646450] Starting subtest: implicit-boths [337.647699] Starting dynamic subtest: rcs0 [337.755870] Dynamic subtest rcs0: SUCCESS (0.108s) [337.766135] Starting dynamic subtest: vcs0 [337.838889] Dynamic subtest vcs0: SUCCESS (0.082s) [337.849275] Starting dynamic subtest: vcs1 [337.920348] Dynamic subtest vcs1: SUCCESS (0.080s) [337.931472] Starting dynamic subtest: vecs0 [337.999950] Dynamic subtest vecs0: SUCCESS (0.079s) [338.008629] Starting dynamic subtest: ccs0 [338.093873] Dynamic subtest ccs0: SUCCESS (0.092s) [338.095662] Subtest implicit-boths: SUCCESS (0.447s) [339.382202] [081/155] (684s left) gem_set_tiling_vs_gtt [339.479854] [082/155] (684s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [339.565261] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [339.566869] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [339.650606] [083/155] (684s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [339.737283] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [339.738987] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s) [339.806527] [084/155] (684s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-render) [339.901358] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-render [339.903068] Subtest hdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [340.007242] [085/155] (684s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [340.110982] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu [340.112906] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [340.196599] [086/155] (684s left) syncobj_timeline (invalid-transfer-non-existent-point) [340.251301] Starting subtest: invalid-transfer-non-existent-point [340.252353] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [340.339991] [087/155] (683s left) kms_content_protection (atomic-dpms-hdcp14) [340.472638] Starting subtest: atomic-dpms-hdcp14 [340.475014] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [340.603516] [088/155] (683s left) gem_reg_read (timestamp-moving) [340.647077] Starting subtest: timestamp-moving [341.657871] Subtest timestamp-moving: SUCCESS (1.001s) [341.720933] [089/155] (682s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [341.818134] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [342.499286] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s) [342.655755] [090/155] (681s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [342.745180] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [342.746762] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [342.834310] [091/155] (681s left) syncobj_timeline (multi-wait-for-submit-signaled) [342.890874] Starting subtest: multi-wait-for-submit-signaled [342.891881] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [343.001108] [092/155] (681s left) syncobj_wait (wait-zero-handles) [343.048513] Starting subtest: wait-zero-handles [343.049535] Subtest wait-zero-handles: SUCCESS (0.000s) [343.153513] [093/155] (681s left) gem_exec_fence (syncobj-signal) [343.596134] Starting subtest: syncobj-signal [343.599614] Subtest syncobj-signal: SUCCESS (0.005s) [345.417011] [094/155] (679s left) gem_create (create-ext-cpu-access-big) [345.584868] Starting subtest: create-ext-cpu-access-big [345.586859] Subtest create-ext-cpu-access-big: SKIP (0.001s) [345.652258] [095/155] (678s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [345.762372] Starting subtest: cursorA-vs-flipB-atomic [345.764132] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [345.902787] [096/155] (678s left) kms_hdr (brightness-with-hdr) [345.986028] Starting subtest: brightness-with-hdr [345.986838] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [345.988354] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [345.996979] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [345.998513] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [346.000170] Subtest brightness-with-hdr: SKIP (0.003s) [346.054632] [097/155] (678s left) i915_drm_fdinfo (virtual-busy-idle-all) [346.086836] Starting subtest: virtual-busy-idle-all [346.088542] Subtest virtual-busy-idle-all: SKIP (0.000s) [346.148150] [098/155] (678s left) kms_force_connector_basic (prune-stale-modes) [346.210374] Starting subtest: prune-stale-modes [346.646022] Subtest prune-stale-modes: SUCCESS (0.436s) [346.777054] [099/155] (677s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [346.832721] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [346.834430] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [347.009659] [100/155] (677s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [347.094327] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [347.096053] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [347.192718] [101/155] (677s left) kms_psr (pr-primary-blt) [347.277809] Starting subtest: pr-primary-blt [347.279733] Subtest pr-primary-blt: SKIP (0.000s) [347.349674] [102/155] (677s left) kms_flip_tiling (flip-change-tiling) [347.435273] Starting subtest: flip-change-tiling [347.436560] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [347.641289] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.205s) [347.654042] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [347.783895] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [347.794846] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [347.926184] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [347.937308] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [348.064608] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s) [348.077744] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [348.207885] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.141s) [348.220816] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [348.352206] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [348.365605] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [348.497073] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s) [348.510508] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [348.619547] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.119s) [348.634880] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [348.772934] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [348.782566] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [348.919816] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.153s) [348.932848] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [349.063435] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [349.078939] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [349.207608] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [349.221565] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [349.353521] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s) [349.366939] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [349.508803] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s) [349.519387] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [349.608145] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s) [349.622043] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [349.752638] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [349.766932] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [349.896877] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [349.910630] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [350.041960] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [350.053449] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [350.185862] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [350.197685] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [350.331564] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s) [350.345549] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [350.474934] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.141s) [350.488389] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [350.597994] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s) [350.609234] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [350.741438] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s) [350.757771] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [350.885415] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [350.897964] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [351.030038] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [351.043604] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [351.174769] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [351.187497] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [351.319254] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [351.334343] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [351.463799] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s) [351.475586] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [351.585855] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s) [351.602785] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [351.730468] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s) [351.743440] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [351.874249] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [351.888543] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [352.019035] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [352.031690] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [352.163866] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [352.175554] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [352.307979] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s) [352.320143] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [352.452805] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s) [352.466234] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [352.586505] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.131s) [352.637999] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [353.907381] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.276s) [353.918592] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [354.040937] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [354.055280] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [354.194671] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [354.206243] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [354.329843] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [354.342799] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [354.474521] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [354.486083] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [354.618040] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [354.631417] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [354.764044] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s) [354.776847] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [354.886432] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.119s) [354.900523] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [355.038744] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [355.047788] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [355.173845] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.141s) [355.186581] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [355.345362] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.170s) [355.357344] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [355.490396] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.141s) [355.503044] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [355.623886] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [355.636772] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [355.757625] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [355.769713] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [355.879368] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.119s) [355.892044] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [356.023561] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [356.036033] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [356.167421] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [356.179617] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [356.312296] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [356.324496] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [356.457032] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s) [356.469990] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [356.602571] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [356.617084] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [356.745884] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [356.757975] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [356.868024] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s) [356.881871] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [357.034670] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.165s) [357.047437] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [357.206809] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.170s) [357.219658] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [357.350664] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [357.361972] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [357.495475] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s) [357.508624] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [357.639958] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [357.653029] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [357.784390] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s) [357.797448] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [357.906728] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s) [357.922380] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [358.050985] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [358.064386] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [358.195437] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [358.208854] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [358.339894] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [358.353220] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [358.484130] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [358.499492] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [358.628764] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.141s) [358.641028] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [358.773302] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s) [358.786584] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [358.895491] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s) [358.951836] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [360.191928] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.251s) [360.204944] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [360.292235] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [360.303750] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [360.392721] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [360.405745] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [360.503275] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [360.515287] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [360.652556] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.147s) [360.663727] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [360.763665] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [360.775392] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [360.864337] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [360.879900] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [360.975428] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s) [360.987180] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [361.086394] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [361.102863] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [361.197624] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [361.213377] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [361.308375] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [361.319861] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [361.419300] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [361.431029] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [361.519436] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [361.530764] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [361.630762] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.108s) [361.644223] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [361.741833] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [361.753665] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [361.852913] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [361.863560] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [361.963960] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.108s) [361.977656] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [362.074802] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [362.087477] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [362.186643] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s) [362.199645] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [362.297443] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [362.310037] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [362.408998] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [362.424567] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [362.519662] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s) [362.539112] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [362.641267] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.120s) [362.655104] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [362.752555] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s) [362.763776] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [362.852578] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.099s) [362.865855] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [362.964195] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [362.978640] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [363.074830] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [363.088700] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [363.185984] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s) [363.198401] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [363.297703] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s) [363.313596] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [363.408684] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s) [363.423829] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [363.519580] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [363.532316] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [363.630490] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [363.646637] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [363.741468] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [363.752262] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [363.852912] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s) [363.865401] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [363.964448] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s) [363.976999] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [364.075659] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s) [364.115822] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [365.396062] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.286s) [365.408439] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [365.495972] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [365.506077] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [365.607441] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s) [365.620897] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [365.718344] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [365.732658] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [365.828924] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s) [365.840838] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [365.947848] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [365.957050] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [366.040306] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [366.052036] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [366.140460] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.097s) [366.154537] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [366.240537] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [366.252738] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [366.351154] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s) [366.364814] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [366.462364] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s) [366.472684] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [366.573407] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [366.584261] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [366.674184] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s) [366.685366] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [366.774577] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [366.785880] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [366.873669] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s) [366.885498] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [366.984768] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [366.998328] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [367.095471] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [367.106802] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [367.207048] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [367.218602] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [367.318205] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s) [367.330539] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [367.429435] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s) [367.441602] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [367.540717] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s) [367.551958] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [367.651508] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [367.663712] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [367.762224] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [367.775868] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [367.873428] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s) [367.886349] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [367.984795] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s) [367.996374] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [368.095716] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s) [368.107492] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [368.206719] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [368.220488] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [368.317828] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s) [368.329258] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [368.429797] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s) [368.443933] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [368.540138] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s) [368.552755] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [368.651404] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [368.666775] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [368.763318] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s) [368.773186] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [368.873526] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s) [368.883842] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [369.023296] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.148s) [369.035182] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [369.134655] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s) [369.147266] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [369.245715] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [369.278472] Subtest flip-change-tiling: SUCCESS (21.843s) [370.444628] [103/155] (654s left) kms_flip (basic-flip-vs-modeset) [370.525482] Starting subtest: basic-flip-vs-modeset [370.527943] Starting dynamic subtest: A-eDP1 [373.090594] Dynamic subtest A-eDP1: SUCCESS (2.562s) [373.099251] Starting dynamic subtest: B-eDP1 [375.289654] Dynamic subtest B-eDP1: SUCCESS (2.197s) [375.298096] Starting dynamic subtest: C-eDP1 [377.484433] Dynamic subtest C-eDP1: SUCCESS (2.194s) [377.492761] Starting dynamic subtest: D-eDP1 [379.684628] Dynamic subtest D-eDP1: SUCCESS (2.199s) [379.685711] Subtest basic-flip-vs-modeset: SUCCESS (9.160s) [380.550066] [104/155] (644s left) kms_chamelium_frames (dp-crc-single) [380.945541] Subtest dp-crc-single: SKIP (0.000s) [381.723954] [105/155] (643s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [381.814172] Starting subtest: pr-plane-move-sf-dmg-area [381.815763] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [381.883702] [106/155] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [381.972759] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [381.974500] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [382.066310] [107/155] (642s left) kms_vblank (ts-continuation-idle-hang) [382.153375] Starting subtest: ts-continuation-idle-hang [382.154281] Starting dynamic subtest: pipe-A-eDP-1 [409.054155] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.898s) [409.065870] Starting dynamic subtest: pipe-D-eDP-1 [434.144086] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.088s) [434.144925] Subtest ts-continuation-idle-hang: SUCCESS (51.991s) [434.961410] [108/155] (590s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt) [435.061520] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt [435.063145] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [435.155707] [109/155] (589s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [435.259757] Starting subtest: fbc-1p-primscrn-cur-indfb-move [439.384029] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.125s) [440.555877] [110/155] (584s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-onoff) [440.645949] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-onoff [440.647837] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [440.746766] [111/155] (584s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [440.795321] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [440.796787] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [440.896572] [112/155] (584s left) i915_suspend (forcewake) [440.951131] Starting subtest: forcewake [473.915186] Subtest forcewake: SUCCESS (3.108s) [487.052278] [113/155] (551s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [487.146950] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [494.167633] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.009s) [494.315016] [114/155] (543s left) gen9_exec_parse (basic-rejected-ctx-param) [494.374844] Subtest basic-rejected-ctx-param: SKIP (0.000s) [494.455556] [115/155] (543s left) gem_eio (in-flight-contexts-1us) [494.672000] Starting subtest: in-flight-contexts-1us [506.198812] Subtest in-flight-contexts-1us: SUCCESS (11.519s) [506.325379] [116/155] (531s left) prime_busy (before) [506.380420] Starting subtest: before [506.382314] Starting dynamic subtest: rcs0 [506.414271] Dynamic subtest rcs0: SUCCESS (0.032s) [506.425967] Starting dynamic subtest: bcs0 [506.466847] Dynamic subtest bcs0: SUCCESS (0.051s) [506.477021] Starting dynamic subtest: vcs0 [506.506372] Dynamic subtest vcs0: SUCCESS (0.039s) [506.515120] Starting dynamic subtest: vcs1 [506.548417] Dynamic subtest vcs1: SUCCESS (0.041s) [506.558308] Starting dynamic subtest: vecs0 [506.591628] Dynamic subtest vecs0: SUCCESS (0.043s) [506.602613] Starting dynamic subtest: ccs0 [506.632636] Dynamic subtest ccs0: SUCCESS (0.039s) [506.740600] Subtest before: SUCCESS (0.360s) [506.816468] [117/155] (531s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [508.336887] Starting subtest: modeset-lpsp-stress-no-wait [518.899532] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.561s) [518.975268] [118/155] (519s left) gem_mmap_gtt (basic-short) [519.026271] Subtest basic-short: SKIP (0.000s) [519.082684] [119/155] (519s left) gem_userptr_blits (stress-mm-invalidate-close) [519.139623] Starting subtest: stress-mm-invalidate-close [521.332907] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [521.425018] [120/155] (517s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu) [521.517607] Starting subtest: fbchdr-rgb565-draw-mmap-cpu [521.519314] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [521.599276] [121/155] (516s left) kms_psr (psr2-primary-mmap-cpu) [521.691438] Starting subtest: psr2-primary-mmap-cpu [521.692399] Starting dynamic subtest: eDP-1 [523.411573] Dynamic subtest eDP-1: SUCCESS (1.720s) [523.412890] Subtest psr2-primary-mmap-cpu: SUCCESS (1.721s) [524.244894] [122/155] (514s left) kms_cursor_crc (cursor-onscreen-256x256) [524.467644] Starting subtest: cursor-onscreen-256x256 [524.471939] Starting dynamic subtest: pipe-A-eDP-1 [526.605442] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.135s) [526.639829] Starting dynamic subtest: pipe-D-eDP-1 [529.427445] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.797s) [529.428530] Subtest cursor-onscreen-256x256: SUCCESS (4.960s) [530.240986] [123/155] (508s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [530.342458] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [530.344145] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [530.446669] [124/155] (508s left) gem_ctx_bad_destroy (double-destroy) [530.504724] Starting subtest: double-destroy [530.505803] Subtest double-destroy: SUCCESS (0.000s) [530.587741] [125/155] (508s left) kms_big_fb (linear-64bpp-rotate-90) [530.693482] Starting subtest: linear-64bpp-rotate-90 [530.712839] Subtest linear-64bpp-rotate-90: SKIP (0.019s) [530.825212] [126/155] (507s left) perf_pmu (init-sema) [530.862765] Starting subtest: init-sema [530.863922] Starting dynamic subtest: rcs0 [530.866790] Dynamic subtest rcs0: SUCCESS (0.002s) [530.877013] Starting dynamic subtest: bcs0 [530.877848] Dynamic subtest bcs0: SUCCESS (0.000s) [530.888057] Starting dynamic subtest: vcs0 [530.888806] Dynamic subtest vcs0: SUCCESS (0.000s) [530.897089] Starting dynamic subtest: vcs1 [530.897894] Dynamic subtest vcs1: SUCCESS (0.001s) [530.906202] Starting dynamic subtest: vecs0 [530.907105] Dynamic subtest vecs0: SUCCESS (0.000s) [530.915678] Starting dynamic subtest: ccs0 [530.916533] Dynamic subtest ccs0: SUCCESS (0.000s) [530.917366] Subtest init-sema: SUCCESS (0.009s) [530.965887] [127/155] (507s left) kms_flip (flip-vs-modeset-vs-hang) [531.058457] Starting subtest: flip-vs-modeset-vs-hang [531.059409] Starting dynamic subtest: A-eDP1 [570.649359] Dynamic subtest A-eDP1: SUCCESS (39.583s) [570.658549] Starting dynamic subtest: D-eDP1 [620.636162] Dynamic subtest D-eDP1: SUCCESS (49.985s) [620.638609] Subtest flip-vs-modeset-vs-hang: SUCCESS (89.574s) [621.037934] [128/155] (417s left) kms_async_flips (crc-atomic) [621.122228] Starting subtest: crc-atomic [621.506912] Starting dynamic subtest: pipe-A-eDP-1 [624.426016] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.919s) [624.815177] Starting dynamic subtest: pipe-B-eDP-1 [627.727217] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.920s) [628.118129] Starting dynamic subtest: pipe-C-eDP-1 [631.008244] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.898s) [631.370740] Starting dynamic subtest: pipe-D-eDP-1 [634.308633] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.946s) [634.309816] Subtest crc-atomic: SUCCESS (13.186s) [635.531782] [129/155] (403s left) syncobj_timeline (etime-multi-wait-submitted) [635.582072] Starting subtest: etime-multi-wait-submitted [635.689180] Subtest etime-multi-wait-submitted: SUCCESS (0.106s) [635.764546] [130/155] (403s left) gem_exec_fence (basic-wait) [635.941307] Starting subtest: basic-wait [635.942114] Starting dynamic subtest: rcs0 [636.019582] Dynamic subtest rcs0: SUCCESS (0.082s) [636.034023] Starting dynamic subtest: bcs0 [636.074653] Dynamic subtest bcs0: SUCCESS (0.053s) [636.087064] Starting dynamic subtest: vcs0 [636.137268] Dynamic subtest vcs0: SUCCESS (0.060s) [636.150130] Starting dynamic subtest: vcs1 [636.200919] Dynamic subtest vcs1: SUCCESS (0.062s) [636.213019] Starting dynamic subtest: vecs0 [636.259325] Dynamic subtest vecs0: SUCCESS (0.056s) [636.272248] Starting dynamic subtest: ccs0 [636.318403] Dynamic subtest ccs0: SUCCESS (0.057s) [636.319711] Subtest basic-wait: SUCCESS (0.383s) [638.294997] [131/155] (400s left) gem_ctx_persistence (engines-persistence) [638.340077] Starting subtest: engines-persistence [638.341218] Starting dynamic subtest: rcs0 [639.166315] Dynamic subtest rcs0: SUCCESS (0.825s) [639.179368] Starting dynamic subtest: bcs0 [639.931477] Dynamic subtest bcs0: SUCCESS (0.763s) [639.944194] Starting dynamic subtest: vcs0 [640.697652] Dynamic subtest vcs0: SUCCESS (0.764s) [640.710051] Starting dynamic subtest: vcs1 [641.446180] Dynamic subtest vcs1: SUCCESS (0.745s) [641.457575] Starting dynamic subtest: vecs0 [642.233667] Dynamic subtest vecs0: SUCCESS (0.787s) [642.246927] Starting dynamic subtest: ccs0 [642.982448] Dynamic subtest ccs0: SUCCESS (0.743s) [642.984368] Subtest engines-persistence: SUCCESS (4.639s) [643.088717] [132/155] (395s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt) [643.179913] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt [643.181478] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [643.273124] [133/155] (395s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [643.368087] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [643.370222] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [643.477599] [134/155] (395s left) dumb_buffer (map-invalid-size) [643.525702] Starting subtest: map-invalid-size [643.526717] Subtest map-invalid-size: SUCCESS (0.000s) [643.611525] [135/155] (395s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-blt) [643.701970] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-blt [643.703759] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [643.784336] [136/155] (395s left) kms_cursor_edge_walk (256x256-left-edge) [643.867385] Starting subtest: 256x256-left-edge [643.868415] Starting dynamic subtest: pipe-A-eDP-1 [647.376795] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s) [647.386341] Starting dynamic subtest: pipe-D-eDP-1 [650.584057] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.206s) [650.585002] Subtest 256x256-left-edge: SUCCESS (6.716s) [651.446909] [137/155] (387s left) kms_plane (pixel-format-yf-tiled-modifier) [651.537209] Starting subtest: pixel-format-yf-tiled-modifier [651.539060] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s) [651.607378] [138/155] (387s left) gem_exec_reloc (basic-cpu-wc-noreloc) [651.661944] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [651.725103] [139/155] (387s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [651.814528] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [651.816248] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [651.917321] [140/155] (387s left) gem_userptr_blits (mmap-offset-banned) [651.985361] Starting subtest: mmap-offset-banned [651.986461] Starting dynamic subtest: wb [651.987427] Dynamic subtest wb: SUCCESS (0.000s) [651.998485] Starting dynamic subtest: wc [651.999326] Dynamic subtest wc: SUCCESS (0.000s) [652.008387] Starting dynamic subtest: uc [652.009215] Dynamic subtest uc: SUCCESS (0.000s) [652.010100] Subtest mmap-offset-banned: SUCCESS (0.002s) [652.112084] [141/155] (387s left) gem_ctx_param (basic-default) [652.164512] Starting subtest: basic-default [652.165492] Subtest basic-default: SUCCESS (0.000s) [652.258905] [142/155] (386s left) gem_mmap_gtt (basic-read) [652.299444] Subtest basic-read: SKIP (0.000s) [652.354381] [143/155] (386s left) i915_drm_fdinfo (memory-info-purgeable) [652.391246] Starting subtest: memory-info-purgeable [652.392212] Starting dynamic subtest: smem0 [655.239338] Dynamic subtest smem0: SUCCESS (2.848s) [655.240577] Subtest memory-info-purgeable: SUCCESS (2.849s) [655.309229] [144/155] (384s left) api_intel_bb (simple-bb) [655.368217] Starting subtest: simple-bb [655.376312] Subtest simple-bb: SUCCESS (0.009s) [655.516542] [145/155] (383s left) gem_pread (self) [655.579980] Subtest self: SKIP (0.000s) [655.646690] [146/155] (383s left) i915_pm_rpm (system-suspend-devices) [657.377292] Starting subtest: system-suspend-devices [665.063471] Subtest system-suspend-devices: SUCCESS (7.687s) [672.499022] [147/155] (373s left) kms_big_fb (y-tiled-8bpp-rotate-180) [672.599269] Starting subtest: y-tiled-8bpp-rotate-180 [672.601243] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [672.689494] [148/155] (373s left) gem_lmem_swapping (heavy-multi) [672.722476] Subtest heavy-multi: SKIP (0.000s) [672.779141] [149/155] (373s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [672.867240] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [673.958399] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.091s) [674.075692] [150/155] (372s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [674.170239] Starting subtest: flip-primary-invalidate-overlay [685.822963] Subtest flip-primary-invalidate-overlay: SUCCESS (11.651s) [685.967017] [151/155] (360s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite) [686.052829] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite [686.054799] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [686.141670] [152/155] (360s left) kms_color (legacy-gamma) [686.238244] Starting subtest: legacy-gamma [686.239308] Starting dynamic subtest: pipe-A-eDP-1 [686.950424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s) [686.959721] Starting dynamic subtest: pipe-B-eDP-1 [688.348009] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s) [688.357198] Starting dynamic subtest: pipe-C-eDP-1 [689.683288] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.335s) [689.693812] Starting dynamic subtest: pipe-D-eDP-1 [691.054586] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.370s) [691.055659] Subtest legacy-gamma: SUCCESS (4.817s) [691.957785] [153/155] (354s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [692.044386] Starting subtest: compare-crc-sanitycheck-nv12 [692.045390] Starting dynamic subtest: pipe-A-eDP-1 [692.741251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s) [692.751057] Starting dynamic subtest: pipe-B-eDP-1 [694.035190] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.292s) [694.044577] Starting dynamic subtest: pipe-C-eDP-1 [695.271902] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s) [695.283043] Starting dynamic subtest: pipe-D-eDP-1 [696.547606] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.273s) [696.548904] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.503s) [697.356904] [154/155] (349s left) kms_vblank (query-forked-busy) [697.446320] Starting subtest: query-forked-busy [697.447270] Starting dynamic subtest: pipe-A-eDP-1 [699.323107] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s) [699.334438] Starting dynamic subtest: pipe-D-eDP-1 [701.873819] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.549s) [701.874800] Subtest query-forked-busy: SUCCESS (4.427s) [702.739629] [155/155] (344s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier) [702.826310] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier [702.828218] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s) [702.906126] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: gem_ctx_persistence results: parsing output: 3/ for test: gem_close_race results: parsing output: 4/ for test: kms_vrr results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: vgem_basic results: parsing output: 7/ for test: kms_atomic results: parsing output: 8/ for test: kms_cursor_crc results: parsing output: 9/ for test: kms_chamelium_color results: parsing output: 10/ for test: kms_ccs results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gem_eio results: parsing output: 13/ for test: gem_exec_params results: parsing output: 14/ for test: gem_exec_schedule results: parsing output: 15/ for test: kms_ccs results: parsing output: 16/ for test: kms_pm_dc results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_feature_discovery results: parsing output: 22/ for test: gem_tiled_swapping results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_psr2_sf results: parsing output: 26/ for test: gem_exec_schedule results: parsing output: 27/ for test: kms_plane_alpha_blend results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: gem_render_copy results: parsing output: 30/ for test: kms_cursor_legacy results: parsing output: 31/ for test: gem_render_copy_redux results: parsing output: 32/ for test: gem_eio results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: gem_barrier_race results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: gem_mmap_offset results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_atomic_interruptible results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: gem_request_retire results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: kms_psr results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_spin_batch results: parsing output: 47/ for test: gem_exec_reloc results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: gem_exec_balancer results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: api_intel_allocator results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_busy results: parsing output: 58/ for test: gem_reg_read results: parsing output: 59/ for test: kms_joiner results: parsing output: 60/ for test: syncobj_wait results: parsing output: 61/ for test: perf results: parsing output: 62/ for test: kms_flip results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: gem_exec_schedule results: parsing output: 66/ for test: gem_mmap results: parsing output: 67/ for test: gem_ctx_shared results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: syncobj_basic results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: gem_mmap_wc results: parsing output: 76/ for test: kms_plane_scaling results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_exec_schedule results: parsing output: 80/ for test: gem_set_tiling_vs_gtt results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_flip_scaled_crc results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: syncobj_timeline results: parsing output: 86/ for test: kms_content_protection results: parsing output: 87/ for test: gem_reg_read results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: syncobj_wait results: parsing output: 92/ for test: gem_exec_fence results: parsing output: 93/ for test: gem_create results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: kms_hdr results: parsing output: 96/ for test: i915_drm_fdinfo results: parsing output: 97/ for test: kms_force_connector_basic results: parsing output: 98/ for test: gem_render_copy results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: kms_flip_tiling results: parsing output: 102/ for test: kms_flip results: parsing output: 103/ for test: kms_chamelium_frames results: parsing output: 104/ for test: kms_psr2_sf results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_vblank results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: i915_suspend results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gen9_exec_parse results: parsing output: 114/ for test: gem_eio results: parsing output: 115/ for test: prime_busy results: parsing output: 116/ for test: kms_pm_rpm results: parsing output: 117/ for test: gem_mmap_gtt results: parsing output: 118/ for test: gem_userptr_blits results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: kms_cursor_crc results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: gem_ctx_bad_destroy results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: perf_pmu results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: kms_async_flips results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: gem_exec_fence results: parsing output: 130/ for test: gem_ctx_persistence results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_big_fb results: parsing output: 133/ for test: dumb_buffer results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_cursor_edge_walk results: parsing output: 136/ for test: kms_plane results: parsing output: 137/ for test: gem_exec_reloc results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: gem_userptr_blits results: parsing output: 140/ for test: gem_ctx_param results: parsing output: 141/ for test: gem_mmap_gtt results: parsing output: 142/ for test: i915_drm_fdinfo results: parsing output: 143/ for test: api_intel_bb results: parsing output: 144/ for test: gem_pread results: parsing output: 145/ for test: i915_pm_rpm results: parsing output: 146/ for test: kms_big_fb results: parsing output: 147/ for test: gem_lmem_swapping results: parsing output: 148/ for test: kms_big_fb results: parsing output: 149/ for test: kms_psr_stress_test results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: kms_color results: parsing output: 152/ for test: kms_pipe_crc_basic results: parsing output: 153/ for test: kms_vblank results: parsing output: 154/ for test: kms_plane Done.