[61.800726] Initializing watchdogs [61.800772] /dev/watchdog0 [61.816353] [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] [61.820502] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.822720] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.826179] [001/133] (960s left) gem_mmap_wc (close) [61.913154] Subtest close: SKIP (0.000s) [61.965194] [002/133] (960s left) kms_setmode (basic) [62.009862] Starting subtest: basic [62.379913] Starting dynamic subtest: pipe-A-eDP-1 [65.935618] Dynamic subtest pipe-A-eDP-1: FAIL (3.433s) [66.150301] Starting dynamic subtest: pipe-B-eDP-1 [68.197083] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.049s) [68.503105] Subtest basic: FAIL (6.495s) [69.344381] [003/133] (953s left) syncobj_timeline (etime-single-wait-submitted) [69.405055] Starting subtest: etime-single-wait-submitted [69.515468] Subtest etime-single-wait-submitted: SUCCESS (0.110s) [69.585701] [004/133] (952s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [69.642044] Starting subtest: legacy-engines-hostile-preempt [69.644523] Starting dynamic subtest: render [69.730767] Dynamic subtest render: SUCCESS (0.088s) [69.738683] Starting dynamic subtest: bsd1 [70.843926] Dynamic subtest bsd1: SUCCESS (1.110s) [70.852821] Starting dynamic subtest: bsd2 [72.916686] Dynamic subtest bsd2: SUCCESS (2.071s) [72.925907] Starting dynamic subtest: blt [72.965317] Dynamic subtest blt: SUCCESS (0.048s) [72.974378] Starting dynamic subtest: vebox [74.897852] Dynamic subtest vebox: SUCCESS (1.931s) [74.900948] Subtest legacy-engines-hostile-preempt: SUCCESS (5.258s) [74.977305] [005/133] (947s left) kms_pm_backlight (basic-brightness) [75.083049] Starting subtest: basic-brightness [75.148731] Starting dynamic subtest: eDP-1 [75.445255] Dynamic subtest eDP-1: SUCCESS (0.297s) [75.447510] Subtest basic-brightness: SUCCESS (0.363s) [76.283628] [006/133] (946s left) kms_psr (fbc-psr-sprite-mmap-cpu) [76.370194] Starting subtest: fbc-psr-sprite-mmap-cpu [76.372461] Starting dynamic subtest: eDP-1 [76.376815] Dynamic subtest eDP-1: SKIP (0.000s) [76.381188] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [76.436771] [007/133] (946s left) kms_ccs (random-ccs-data-y-tiled-ccs) [76.526600] Starting subtest: random-ccs-data-y-tiled-ccs [76.528856] Starting dynamic subtest: pipe-A-eDP-1 [76.553533] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [76.560982] Starting dynamic subtest: pipe-B-eDP-1 [76.584133] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [76.590567] Starting dynamic subtest: pipe-C-eDP-1 [76.613332] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [76.619656] Starting dynamic subtest: pipe-D-eDP-1 [76.643566] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [76.647605] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s) [78.761298] [008/133] (943s left) gem_mmap_gtt (zero-extend) [78.814337] Subtest zero-extend: SKIP (0.000s) [78.862932] [009/133] (943s left) sysfs_timeslice_duration (idempotent) [78.924832] Starting subtest: idempotent [78.927219] Starting dynamic subtest: vecs0 [78.929631] Dynamic subtest vecs0: SUCCESS (0.000s) [78.936662] Starting dynamic subtest: ccs0 [78.938927] Dynamic subtest ccs0: SUCCESS (0.000s) [78.945619] Starting dynamic subtest: vcs0 [78.947863] Dynamic subtest vcs0: SUCCESS (0.000s) [78.954354] Starting dynamic subtest: bcs0 [78.956561] Dynamic subtest bcs0: SUCCESS (0.000s) [78.963890] Starting dynamic subtest: rcs0 [78.966140] Dynamic subtest rcs0: SUCCESS (0.000s) [78.972763] Starting dynamic subtest: vcs1 [78.974681] Dynamic subtest vcs1: SUCCESS (0.000s) [78.976694] Subtest idempotent: SUCCESS (0.004s) [79.029213] [010/133] (943s left) gem_eio (wait-wedge-1us) [79.197758] Starting subtest: wait-wedge-1us [80.959869] Subtest wait-wedge-1us: SUCCESS (1.763s) [81.073888] [011/133] (941s left) gem_exec_schedule (independent) [81.148794] Starting subtest: independent [81.151186] Starting dynamic subtest: rcs0 [82.902470] Dynamic subtest rcs0: SUCCESS (1.757s) [82.921640] Starting dynamic subtest: vcs0 [84.897051] Dynamic subtest vcs0: SUCCESS (1.994s) [84.908512] Starting dynamic subtest: vcs1 [86.944042] Dynamic subtest vcs1: SUCCESS (2.046s) [86.975492] Starting dynamic subtest: vecs0 [88.931025] Dynamic subtest vecs0: SUCCESS (1.986s) [88.941339] Starting dynamic subtest: ccs0 [90.901064] Dynamic subtest ccs0: SUCCESS (1.969s) [90.903935] Subtest independent: SUCCESS (9.757s) [91.201197] [012/133] (931s left) syncobj_wait (invalid-wait-illegal-handle) [91.264846] Starting subtest: invalid-wait-illegal-handle [91.267221] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [91.353925] [013/133] (931s left) gem_ctx_persistence (engines-cleanup) [91.410734] Starting subtest: engines-cleanup [91.412972] Starting dynamic subtest: rcs0 [91.481186] Dynamic subtest rcs0: SUCCESS (0.070s) [91.491995] Starting dynamic subtest: bcs0 [91.517562] Dynamic subtest bcs0: SUCCESS (0.036s) [91.528232] Starting dynamic subtest: vcs0 [91.566958] Dynamic subtest vcs0: SUCCESS (0.048s) [91.577318] Starting dynamic subtest: vcs1 [91.605461] Dynamic subtest vcs1: SUCCESS (0.038s) [91.613349] Starting dynamic subtest: vecs0 [91.652586] Dynamic subtest vecs0: SUCCESS (0.046s) [91.662282] Starting dynamic subtest: ccs0 [91.707899] Dynamic subtest ccs0: SUCCESS (0.054s) [91.710569] Subtest engines-cleanup: SUCCESS (0.297s) [91.786108] [014/133] (931s left) kms_psr (pr-suspend) [91.876810] Starting subtest: pr-suspend [91.881196] Subtest pr-suspend: SKIP (0.000s) [91.946134] [015/133] (930s left) perf_pmu (busy-idle) [91.985640] Starting subtest: busy-idle [91.987498] Starting dynamic subtest: rcs0 [92.674869] Dynamic subtest rcs0: SUCCESS (0.690s) [92.683864] Starting dynamic subtest: bcs0 [93.332481] Dynamic subtest bcs0: SUCCESS (0.657s) [93.341783] Starting dynamic subtest: vcs0 [94.932952] Dynamic subtest vcs0: SUCCESS (1.598s) [94.941729] Starting dynamic subtest: vcs1 [96.917324] Dynamic subtest vcs1: SUCCESS (1.983s) [96.928489] Starting dynamic subtest: vecs0 [98.902884] Dynamic subtest vecs0: SUCCESS (1.984s) [98.911848] Starting dynamic subtest: ccs0 [99.566155] Dynamic subtest ccs0: SUCCESS (0.664s) [99.568674] Subtest busy-idle: SUCCESS (7.583s) [99.683660] [016/133] (923s left) kms_plane_cursor (primary) [99.798866] Starting subtest: primary [99.803515] Starting dynamic subtest: pipe-A-eDP-1-size-64 [102.352292] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.555s) [102.377736] Starting dynamic subtest: pipe-A-eDP-1-size-128 [104.931072] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.561s) [104.955544] Starting dynamic subtest: pipe-A-eDP-1-size-256 [107.521787] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s) [107.836997] Starting dynamic subtest: pipe-B-eDP-1-size-64 [111.160693] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.331s) [111.183921] Starting dynamic subtest: pipe-B-eDP-1-size-128 [113.783986] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.605s) [113.805567] Starting dynamic subtest: pipe-B-eDP-1-size-256 [116.362938] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s) [116.676786] Starting dynamic subtest: pipe-C-eDP-1-size-64 [119.605315] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.939s) [119.631116] Starting dynamic subtest: pipe-C-eDP-1-size-128 [121.794279] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.170s) [121.820172] Starting dynamic subtest: pipe-C-eDP-1-size-256 [124.005112] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s) [124.325457] Starting dynamic subtest: pipe-D-eDP-1-size-64 [127.251913] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.940s) [127.278756] Starting dynamic subtest: pipe-D-eDP-1-size-128 [129.418155] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.147s) [129.443766] Starting dynamic subtest: pipe-D-eDP-1-size-256 [131.584497] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s) [131.892104] Subtest primary: SUCCESS (32.092s) [132.723597] [017/133] (890s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [132.820202] Starting subtest: async-flip-with-page-flip-events-tiled [133.199825] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [135.992915] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.793s) [136.003567] Starting dynamic subtest: pipe-A-eDP-1-4 [138.178893] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s) [138.186861] Starting dynamic subtest: pipe-A-eDP-1-4 [140.188610] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [140.196335] Starting dynamic subtest: pipe-A-eDP-1-x [142.367488] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [142.733725] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [145.525088] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.797s) [145.532993] Starting dynamic subtest: pipe-B-eDP-1-4 [147.711526] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [147.719570] Starting dynamic subtest: pipe-B-eDP-1-4 [149.722461] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [149.733050] Starting dynamic subtest: pipe-B-eDP-1-x [151.912331] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s) [152.276883] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [155.056152] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.786s) [155.067357] Starting dynamic subtest: pipe-C-eDP-1-4 [157.253291] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.196s) [157.261327] Starting dynamic subtest: pipe-C-eDP-1-4 [159.264362] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s) [159.272672] Starting dynamic subtest: pipe-C-eDP-1-x [161.443613] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s) [161.812659] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [164.582977] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.782s) [164.591234] Starting dynamic subtest: pipe-D-eDP-1-4 [166.745913] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.162s) [166.754253] Starting dynamic subtest: pipe-D-eDP-1-4 [168.757074] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s) [168.765089] Starting dynamic subtest: pipe-D-eDP-1-x [170.925039] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.166s) [170.927563] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.104s) [172.081493] [018/133] (850s left) kms_cursor_crc (cursor-rapid-movement-512x512) [172.364071] Starting subtest: cursor-rapid-movement-512x512 [172.368559] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [172.521480] [019/133] (850s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [172.623799] Starting subtest: psr2-plane-move-sf-dmg-area [172.626030] Starting dynamic subtest: pipe-A-eDP-1 [177.109305] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.489s) [177.117178] Starting dynamic subtest: pipe-B-eDP-1 [182.450274] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.340s) [182.452800] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.832s) [183.317705] [020/133] (839s left) gem_spin_batch (spin-each) [183.380702] Starting subtest: spin-each [186.647803] Subtest spin-each: SUCCESS (3.260s) [186.985245] [021/133] (836s left) gem_eio (in-flight-internal-immediate) [187.183710] Starting subtest: in-flight-internal-immediate [188.952209] Subtest in-flight-internal-immediate: SUCCESS (1.766s) [189.066635] [022/133] (834s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip) [189.166067] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip [189.170648] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [189.253229] [023/133] (833s left) syncobj_timeline (transfer-timeline-point) [189.313600] Starting subtest: transfer-timeline-point [189.315591] Subtest transfer-timeline-point: SUCCESS (0.000s) [189.412543] [024/133] (833s left) core_getversion (all-cards) [189.458873] Starting subtest: all-cards [189.466414] Subtest all-cards: SUCCESS (0.009s) [189.509228] [025/133] (833s left) kms_fbcon_fbt (psr) [189.567405] Starting subtest: psr [196.835641] Subtest psr: SUCCESS (7.263s) [196.906837] [026/133] (826s left) kms_universal_plane (cursor-fb-leak) [196.991016] Starting subtest: cursor-fb-leak [196.993387] Starting dynamic subtest: pipe-A-eDP-1 [197.329490] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.340s) [197.344577] Starting dynamic subtest: pipe-B-eDP-1 [198.670652] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.338s) [198.681368] Starting dynamic subtest: pipe-C-eDP-1 [199.992655] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.319s) [200.003541] Starting dynamic subtest: pipe-D-eDP-1 [201.334217] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s) [201.336695] Subtest cursor-fb-leak: SUCCESS (4.345s) [202.477373] [027/133] (820s left) gem_exec_fence (syncobj-timeline-export) [203.082193] Starting subtest: syncobj-timeline-export [203.088289] Subtest syncobj-timeline-export: SUCCESS (0.007s) [203.913977] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true [203.917756] [028/133] (819s left) gem_mmap_gtt (cpuset-big-copy) [203.987668] Subtest cpuset-big-copy: SKIP (0.000s) [204.049186] [029/133] (819s left) kms_psr (psr2-cursor-render) [204.149999] Starting subtest: psr2-cursor-render [204.152300] Starting dynamic subtest: eDP-1 [205.850084] Dynamic subtest eDP-1: SUCCESS (1.700s) [205.852240] Subtest psr2-cursor-render: SUCCESS (1.702s) [206.646688] [030/133] (816s left) kms_rmfb (rmfb-ioctl) [206.756780] Starting subtest: rmfb-ioctl [206.758661] Starting dynamic subtest: pipe-A-eDP-1 [206.861470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [206.871158] Starting dynamic subtest: pipe-B-eDP-1 [208.004020] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s) [208.012502] Starting dynamic subtest: pipe-C-eDP-1 [209.125529] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s) [209.134427] Starting dynamic subtest: pipe-D-eDP-1 [210.248249] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s) [210.250631] Subtest rmfb-ioctl: SUCCESS (3.494s) [211.455234] [031/133] (812s left) gem_mmap_wc (read) [211.513966] Subtest read: SKIP (0.000s) [211.589703] [032/133] (811s left) kms_big_fb (y-tiled-addfb) [211.678897] Starting subtest: y-tiled-addfb [211.683290] Subtest y-tiled-addfb: SKIP (0.000s) [211.779987] [033/133] (811s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [211.876876] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [211.881697] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [211.975979] [034/133] (811s left) kms_prop_blob (blob-prop-core) [212.032069] Starting subtest: blob-prop-core [212.034196] Subtest blob-prop-core: SUCCESS (0.000s) [212.122471] [035/133] (811s left) gem_busy (extended) [212.297647] Starting subtest: extended [212.300324] Starting dynamic subtest: rcs0 [212.372490] Dynamic subtest rcs0: SUCCESS (0.075s) [212.383115] Starting dynamic subtest: bcs0 [212.414964] Dynamic subtest bcs0: SUCCESS (0.040s) [212.424459] Starting dynamic subtest: vcs0 [213.909490] Dynamic subtest vcs0: SUCCESS (1.490s) [213.920717] Starting dynamic subtest: vcs1 [215.894535] Dynamic subtest vcs1: SUCCESS (1.982s) [215.905965] Starting dynamic subtest: vecs0 [217.941618] Dynamic subtest vecs0: SUCCESS (2.043s) [217.952931] Starting dynamic subtest: ccs0 [217.986698] Dynamic subtest ccs0: SUCCESS (0.044s) [217.989205] Subtest extended: SUCCESS (5.691s) [218.218700] [036/133] (805s left) kms_atomic_interruptible (universal-setplane-cursor) [218.328920] Starting subtest: universal-setplane-cursor [218.331083] Starting dynamic subtest: pipe-A-eDP-1 [225.770030] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.439s) [225.772400] Subtest universal-setplane-cursor: SUCCESS (7.440s) [226.627155] [037/133] (797s left) kms_cursor_edge_walk (256x256-right-edge) [226.718623] Starting subtest: 256x256-right-edge [226.720724] Starting dynamic subtest: pipe-A-eDP-1 [230.193711] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s) [230.202875] Starting dynamic subtest: pipe-D-eDP-1 [233.322446] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s) [233.324723] Subtest 256x256-right-edge: SUCCESS (6.605s) [234.130464] [038/133] (789s left) gem_eio (in-flight-1us) [234.357988] Starting subtest: in-flight-1us [242.541215] Subtest in-flight-1us: SUCCESS (8.180s) [242.697758] [039/133] (781s left) kms_pm_rpm (dpms-non-lpsp) [244.226773] Starting subtest: dpms-non-lpsp [244.232164] Subtest dpms-non-lpsp: SKIP (0.001s) [244.971450] [040/133] (778s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [245.024248] Subtest writes-after-reads-uncached: SKIP (0.000s) [245.096490] [041/133] (778s left) syncobj_timeline (multi-wait-all-available-submitted) [245.146738] Starting subtest: multi-wait-all-available-submitted [245.148674] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s) [245.237129] [042/133] (778s left) syncobj_wait (multi-wait-submitted) [245.289063] Starting subtest: multi-wait-submitted [245.393547] Subtest multi-wait-submitted: SUCCESS (0.103s) [245.472771] [043/133] (778s left) gem_mmap_wc (bad-size) [245.526779] Subtest bad-size: SKIP (0.000s) [245.587274] [044/133] (778s left) gem_exec_schedule (reorder-wide) [245.757884] Subtest reorder-wide: SKIP (0.000s) [245.939609] [045/133] (778s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [246.038059] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [247.139854] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.101s) [247.259966] [046/133] (776s left) kms_color (invalid-degamma-lut-sizes) [247.354027] Starting subtest: invalid-degamma-lut-sizes [247.355824] Starting dynamic subtest: pipe-A [247.653189] Dynamic subtest pipe-A: SUCCESS (0.297s) [247.663027] Starting dynamic subtest: pipe-B [247.665575] Dynamic subtest pipe-B: SUCCESS (0.000s) [247.673919] Starting dynamic subtest: pipe-C [247.676585] Dynamic subtest pipe-C: SUCCESS (0.000s) [247.684741] Starting dynamic subtest: pipe-D [247.686739] Dynamic subtest pipe-D: SUCCESS (0.000s) [247.688649] Subtest invalid-degamma-lut-sizes: SUCCESS (0.300s) [248.488099] [047/133] (775s left) kms_setmode (invalid-clone-exclusive-crtc) [248.547829] Starting subtest: invalid-clone-exclusive-crtc [248.553894] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [248.634998] [048/133] (775s left) gem_exec_suspend (basic-s0) [248.708630] Starting subtest: basic-S0 [248.711085] Starting dynamic subtest: smem [268.383706] Dynamic subtest smem: SUCCESS (7.192s) [268.386701] Subtest basic-S0: SUCCESS (7.194s) [268.572319] [049/133] (755s left) kms_content_protection (lic-type-1) [268.733361] Starting subtest: lic-type-1 [268.738097] Subtest lic-type-1: SKIP (0.000s) [268.854883] [050/133] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [268.948853] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [268.953021] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [269.049852] [051/133] (755s left) gem_mmap (short-mmap) [269.114409] Subtest short-mmap: SKIP (0.000s) [269.172426] [052/133] (755s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [269.262432] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [272.929639] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.687s) [274.104747] [053/133] (750s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [274.216790] Starting subtest: 2x-wf_vblank-ts-check-interruptible [274.227780] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s) [274.301192] [054/133] (750s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [274.394358] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [274.398449] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [274.498950] [055/133] (750s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [274.604958] Starting subtest: modeset-atomic-cursor-hotspot [274.609507] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [274.745707] [056/133] (749s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [274.848903] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [274.853057] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [274.957639] [057/133] (749s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [275.045357] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [275.046875] Starting dynamic subtest: pipe-A-eDP-1 [275.183678] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.129s) [275.194616] Starting dynamic subtest: pipe-B-eDP-1 [275.211692] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [275.220463] Starting dynamic subtest: pipe-C-eDP-1 [275.236696] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [275.245200] Starting dynamic subtest: pipe-D-eDP-1 [275.262966] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [275.264719] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.138s) [277.482610] [058/133] (747s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [277.554835] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [277.609471] [059/133] (747s left) gem_exec_reloc (basic-cpu-wc-noreloc) [277.667995] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [277.744588] [060/133] (746s left) kms_invalid_mode (bad-vsync-start) [277.830541] Starting subtest: bad-vsync-start [277.832842] Starting dynamic subtest: pipe-A-eDP-1 [278.118383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s) [278.127952] Starting dynamic subtest: pipe-B-eDP-1 [278.130105] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [278.138794] Starting dynamic subtest: pipe-C-eDP-1 [278.141054] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [278.149337] Starting dynamic subtest: pipe-D-eDP-1 [278.151210] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [278.153134] Subtest bad-vsync-start: SUCCESS (0.296s) [278.924544] [061/133] (745s left) kms_lease (multimaster-lease) [279.010979] Starting subtest: multimaster-lease [279.013167] Subtest multimaster-lease: SUCCESS (0.003s) [279.119358] [062/133] (745s left) kms_cursor_crc (cursor-onscreen-256x256) [279.388896] Starting subtest: cursor-onscreen-256x256 [279.391079] Starting dynamic subtest: pipe-A-eDP-1 [281.482936] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s) [281.511675] Starting dynamic subtest: pipe-D-eDP-1 [284.293560] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.790s) [284.295482] Subtest cursor-onscreen-256x256: SUCCESS (4.911s) [285.166001] [063/133] (739s left) perf_pmu (busy-hang) [285.210392] Starting subtest: busy-hang [285.212605] Starting dynamic subtest: rcs0 [286.473075] Dynamic subtest rcs0: SUCCESS (1.261s) [286.481943] Starting dynamic subtest: bcs0 [287.705178] Dynamic subtest bcs0: SUCCESS (1.234s) [287.718528] Starting dynamic subtest: vcs0 [289.895745] Dynamic subtest vcs0: SUCCESS (2.187s) [289.905419] Starting dynamic subtest: vcs1 [291.931308] Dynamic subtest vcs1: SUCCESS (2.039s) [291.942975] Starting dynamic subtest: vecs0 [293.921930] Dynamic subtest vecs0: SUCCESS (1.987s) [293.932409] Starting dynamic subtest: ccs0 [295.153556] Dynamic subtest ccs0: SUCCESS (1.234s) [295.156245] Subtest busy-hang: SUCCESS (9.953s) [295.253188] [064/133] (729s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [295.325925] Starting subtest: mixed-tiled-to-yf-tiled-ccs [295.330574] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s) [295.531674] [065/133] (729s left) i915_drm_fdinfo (busy) [295.578484] Starting subtest: busy [295.581128] Starting dynamic subtest: rcs0 [295.601823] Dynamic subtest rcs0: SKIP (0.021s) [295.613516] Starting dynamic subtest: bcs0 [295.618012] Dynamic subtest bcs0: SKIP (0.000s) [295.627054] Starting dynamic subtest: vcs0 [295.631430] Dynamic subtest vcs0: SKIP (0.000s) [295.640257] Starting dynamic subtest: vcs1 [295.644604] Dynamic subtest vcs1: SKIP (0.000s) [295.656119] Starting dynamic subtest: vecs0 [295.660836] Dynamic subtest vecs0: SKIP (0.000s) [295.669860] Starting dynamic subtest: ccs0 [295.674153] Dynamic subtest ccs0: SKIP (0.000s) [295.679261] Subtest busy: SKIP (0.026s) [295.720954] [066/133] (729s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [296.107084] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [296.886761] [067/133] (728s left) gem_userptr_blits (stress-mm-invalidate-close) [296.959675] Starting subtest: stress-mm-invalidate-close [299.107443] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [299.226032] [068/133] (725s left) gem_ctx_shared (disjoint-timelines) [299.293626] Starting subtest: disjoint-timelines [299.323891] Subtest disjoint-timelines: SUCCESS (0.031s) [299.549507] [069/133] (725s left) perf_pmu (semaphore-wait-idle) [299.589593] Starting subtest: semaphore-wait-idle [299.592010] Starting dynamic subtest: rcs0 [300.102675] Dynamic subtest rcs0: SUCCESS (0.513s) [300.112879] Starting dynamic subtest: bcs0 [300.620696] Dynamic subtest bcs0: SUCCESS (0.516s) [300.632677] Starting dynamic subtest: vcs0 [301.136441] Dynamic subtest vcs0: SUCCESS (0.513s) [301.147808] Starting dynamic subtest: vcs1 [301.650659] Dynamic subtest vcs1: SUCCESS (0.512s) [301.662573] Starting dynamic subtest: vecs0 [302.166667] Dynamic subtest vecs0: SUCCESS (0.514s) [302.178188] Starting dynamic subtest: ccs0 [302.682136] Dynamic subtest ccs0: SUCCESS (0.513s) [302.685219] Subtest semaphore-wait-idle: SUCCESS (3.097s) [302.801430] [070/133] (722s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [302.902660] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [302.906753] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [303.006734] [071/133] (722s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [303.101915] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [303.104170] Starting dynamic subtest: pipe-A-eDP-1 [303.161882] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s) [303.172675] Starting dynamic subtest: pipe-B-eDP-1 [303.228734] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [303.239360] Starting dynamic subtest: pipe-C-eDP-1 [303.297068] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [303.307297] Starting dynamic subtest: pipe-D-eDP-1 [303.363493] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [303.367744] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s) [305.364532] [072/133] (719s left) gem_huc_copy (huc-copy) [305.418289] Starting subtest: huc-copy [305.420582] Subtest huc-copy: SUCCESS (0.005s) [305.537074] [073/133] (719s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [305.608983] Starting subtest: y-tiled-to-vebox-yf-tiled [305.613379] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [305.792165] [074/133] (719s left) i915_drm_fdinfo (virtual-idle) [305.832811] Starting subtest: virtual-idle [308.891534] Subtest virtual-idle: SUCCESS (3.061s) [308.965797] [075/133] (716s left) i915_pm_rps (min-max-config-loaded) [309.030741] Starting subtest: min-max-config-loaded [309.035209] Subtest min-max-config-loaded: SKIP (0.002s) [309.145591] [076/133] (716s left) kms_big_fb (x-tiled-32bpp-rotate-90) [309.249572] Starting subtest: x-tiled-32bpp-rotate-90 [309.269463] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s) [309.381616] [077/133] (716s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [309.479656] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [309.483995] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [309.598657] [078/133] (715s left) syncobj_wait (multi-wait-all-submitted-signaled) [309.652878] Starting subtest: multi-wait-all-submitted-signaled [309.753713] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.102s) [309.831932] [079/133] (715s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [309.901534] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [309.965187] [080/133] (715s left) kms_vblank (query-forked-busy-hang) [310.055370] Starting subtest: query-forked-busy-hang [310.057198] Starting dynamic subtest: pipe-A-eDP-1 [336.161587] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.118s) [336.175644] Starting dynamic subtest: pipe-D-eDP-1 [361.173853] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.023s) [361.176245] Subtest query-forked-busy-hang: SUCCESS (51.145s) [361.986195] [081/133] (663s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [362.090276] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [362.117112] Starting dynamic subtest: pipe-A-plane-0 [362.796384] Dynamic subtest pipe-A-plane-0: SUCCESS (0.677s) [362.806437] Starting dynamic subtest: pipe-A-plane-3 [363.241681] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s) [364.370310] Starting dynamic subtest: pipe-B-plane-0 [365.041425] Dynamic subtest pipe-B-plane-0: SUCCESS (0.678s) [365.051508] Starting dynamic subtest: pipe-B-plane-3 [365.486732] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s) [365.795192] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.696s) [366.657805] [082/133] (659s left) kms_big_fb (4-tiled-8bpp-rotate-0) [366.762679] Starting subtest: 4-tiled-8bpp-rotate-0 [367.989975] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.225s) [368.091450] [083/133] (657s left) gem_exec_reloc (basic-write-read-noreloc) [368.154148] Subtest basic-write-read-noreloc: SKIP (0.000s) [368.226210] [084/133] (657s left) kms_flip_tiling (flip-change-tiling) [368.317884] Starting subtest: flip-change-tiling [368.319811] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs [368.491293] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.173s) [368.503528] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs [368.626704] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [368.638879] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [368.760101] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [368.774046] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4 [368.904025] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.143s) [368.916216] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x [369.047627] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [369.059887] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear [369.193026] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [369.205417] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs [369.326894] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [369.339617] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs [369.438183] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s) [369.450661] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [369.572300] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [369.584138] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4 [369.716523] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [369.728186] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x [369.860793] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [369.872989] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear [370.005270] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [370.020096] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [370.139027] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [370.151343] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [370.285581] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s) [370.298147] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [370.395440] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s) [370.407543] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4 [370.540046] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [370.552155] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x [370.684384] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [370.698379] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear [370.829101] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [370.841358] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs [370.962998] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s) [370.975092] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs [371.108068] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s) [371.121792] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc [371.252750] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.141s) [371.265246] Starting dynamic subtest: pipe-A-eDP-1-4-to-4 [371.374307] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s) [371.389157] Starting dynamic subtest: pipe-A-eDP-1-4-to-x [371.518685] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s) [371.532367] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear [371.663194] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s) [371.677131] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs [371.808747] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [371.820605] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs [371.963968] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.153s) [371.973197] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc [372.108749] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s) [372.121135] Starting dynamic subtest: pipe-A-eDP-1-x-to-4 [372.253450] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s) [372.267646] Starting dynamic subtest: pipe-A-eDP-1-x-to-x [372.375786] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s) [372.387645] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear [372.521031] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s) [372.532175] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs [372.664839] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [372.677602] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs [372.811737] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [372.822774] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc [372.955058] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [372.965832] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4 [373.121347] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.164s) [373.134536] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x [373.266284] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s) [373.278675] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear [373.388803] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s) [373.444734] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs [374.638486] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.203s) [374.650560] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs [374.773303] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s) [374.787684] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [374.917496] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s) [374.931250] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4 [375.061651] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s) [375.073961] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x [375.205873] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s) [375.218216] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear [375.350290] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s) [375.362761] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs [375.484435] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s) [375.497216] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs [375.595008] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s) [375.606812] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [375.729772] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s) [375.740667] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4 [375.873666] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s) [375.885954] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x [376.017651] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s) [376.030285] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear [376.162294] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s) [376.175123] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [376.296713] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s) [376.309155] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [376.431408] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s) [376.443550] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [376.541268] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s) [376.553268] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4 [376.685960] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s) [376.698239] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x [376.829588] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s) [376.841989] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear [376.974611] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s) [376.987061] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs [377.108220] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s) [377.120639] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs [377.242149] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s) [377.255118] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc [377.386692] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s) [377.399991] Starting dynamic subtest: pipe-B-eDP-1-4-to-4 [377.508273] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s) [377.520582] Starting dynamic subtest: pipe-B-eDP-1-4-to-x [377.652716] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s) [377.664906] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear [377.797561] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s) [377.809533] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs [377.941661] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s) [377.955778] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs [378.097174] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.152s) [378.109536] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc [378.253181] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.153s) [378.265404] Starting dynamic subtest: pipe-B-eDP-1-x-to-4 [378.397738] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s) [378.413403] Starting dynamic subtest: pipe-B-eDP-1-x-to-x [378.520184] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s) [378.533548] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear [378.665067] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s) [378.680198] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs [378.809517] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s) [378.821116] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs [378.953609] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s) [378.968603] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc [379.098211] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s) [379.114587] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4 [379.243135] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s) [379.254177] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x [379.387897] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s) [379.399389] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear [379.521093] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.131s) [379.573627] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs [380.778101] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.209s) [380.790610] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs [380.878302] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [380.890559] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [380.977997] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.097s) [380.990303] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4 [381.089257] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s) [381.101989] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x [381.199615] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s) [381.211780] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear [381.310851] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [381.322723] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs [381.412044] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [381.424555] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs [381.511766] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [381.524313] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [381.611581] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [381.626925] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4 [381.711574] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s) [381.722893] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x [381.822452] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s) [381.833422] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear [381.933525] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [381.948029] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [382.034188] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [382.048400] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [382.134131] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [382.146321] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [382.234276] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s) [382.246252] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4 [382.345546] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [382.357852] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x [382.456150] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s) [382.467637] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear [382.567302] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [382.581295] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs [382.667282] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s) [382.679498] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs [382.767871] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s) [382.783982] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc [382.879024] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s) [382.890607] Starting dynamic subtest: pipe-C-eDP-1-4-to-4 [382.990201] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s) [383.005625] Starting dynamic subtest: pipe-C-eDP-1-4-to-x [383.101175] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s) [383.110699] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear [383.212198] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s) [383.223660] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs [383.312396] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s) [383.322747] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs [383.423320] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s) [383.433694] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc [383.523292] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.098s) [383.534748] Starting dynamic subtest: pipe-C-eDP-1-x-to-4 [383.634795] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s) [383.648939] Starting dynamic subtest: pipe-C-eDP-1-x-to-x [383.757283] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.120s) [383.774870] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear [383.868459] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s) [383.880616] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs [383.968127] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s) [383.981701] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs [384.068088] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s) [384.080334] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc [384.168391] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.099s) [384.179856] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4 [384.279619] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s) [384.291009] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x [384.391277] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s) [384.405791] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear [384.502297] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s) [384.543049] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs [385.737591] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.200s) [385.749433] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs [385.837810] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s) [385.850240] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc [385.937823] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [385.949281] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4 [386.037306] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.098s) [386.047697] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x [386.148031] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.108s) [386.162444] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear [386.259624] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s) [386.274772] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs [386.359983] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s) [386.372124] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs [386.460439] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.097s) [386.474839] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc [386.559875] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s) [386.570979] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4 [386.659777] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s) [386.671302] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x [386.759403] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.098s) [386.771109] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear [386.870591] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s) [386.882473] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs [386.970786] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s) [386.981894] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs [387.070981] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s) [387.085281] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc [387.222432] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.146s) [387.234444] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4 [387.332221] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s) [387.344600] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x [387.442897] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s) [387.453738] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear [387.554086] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s) [387.572589] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs [387.654497] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s) [387.666022] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs [387.754910] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s) [387.767098] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc [387.854919] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s) [387.866538] Starting dynamic subtest: pipe-D-eDP-1-4-to-4 [387.965918] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s) [387.977681] Starting dynamic subtest: pipe-D-eDP-1-4-to-x [388.076934] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s) [388.088707] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear [388.187948] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s) [388.199577] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs [388.287379] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s) [388.298100] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs [388.399094] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s) [388.409319] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc [388.509860] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s) [388.521636] Starting dynamic subtest: pipe-D-eDP-1-x-to-4 [388.660025] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.148s) [388.672814] Starting dynamic subtest: pipe-D-eDP-1-x-to-x [388.782310] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.119s) [388.791943] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear [388.893625] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s) [388.905867] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs [389.004096] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s) [389.018142] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs [389.104899] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s) [389.115468] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc [389.204465] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.098s) [389.214678] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4 [389.315688] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s) [389.325958] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x [389.427027] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s) [389.438930] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear [389.538170] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s) [389.571142] Subtest flip-change-tiling: SUCCESS (21.232s) [390.734390] [085/133] (635s left) kms_hdr (invalid-metadata-sizes) [390.842542] Starting subtest: invalid-metadata-sizes [390.848816] Subtest invalid-metadata-sizes: SKIP (0.000s) [390.915213] [086/133] (634s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [391.294976] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [392.157407] [087/133] (633s left) perf (enable-disable) [392.281956] Starting subtest: enable-disable [392.284174] Starting dynamic subtest: 0-rcs0 [394.526572] Dynamic subtest 0-rcs0: SUCCESS (2.243s) [394.538461] Starting dynamic subtest: 1-vcs1 [398.990347] Dynamic subtest 1-vcs1: SUCCESS (4.461s) [398.992700] Subtest enable-disable: SUCCESS (6.707s) [399.041446] [088/133] (626s left) kms_flip (flip-vs-suspend-interruptible) [399.142417] Starting subtest: flip-vs-suspend-interruptible [399.144738] Starting dynamic subtest: A-eDP1 [448.373765] Dynamic subtest A-eDP1: SUCCESS (4.522s) [448.390440] Starting dynamic subtest: B-eDP1 [497.374241] Dynamic subtest B-eDP1: SUCCESS (4.522s) [497.388639] Starting dynamic subtest: C-eDP1 [546.378168] Dynamic subtest C-eDP1: SUCCESS (4.528s) [546.389678] Starting dynamic subtest: D-eDP1 [595.377637] Dynamic subtest D-eDP1: SUCCESS (4.531s) [595.380625] Subtest flip-vs-suspend-interruptible: SUCCESS (18.113s) [596.560262] [089/133] (429s left) api_intel_bb (bb-with-allocator) [596.624343] Starting subtest: bb-with-allocator [596.630254] Subtest bb-with-allocator: SUCCESS (0.007s) [596.743106] [090/133] (429s left) gem_render_copy_redux (flink-interruptible) [596.798955] Starting subtest: flink-interruptible [597.573611] Subtest flink-interruptible: SUCCESS (0.778s) [597.698666] [091/133] (428s left) gem_partial_pwrite_pread (reads) [597.755273] Subtest reads: SKIP (0.000s) [597.827405] [092/133] (428s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [597.912935] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [597.915095] Starting dynamic subtest: pipe-A-eDP-1 [597.935861] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [597.948284] Starting dynamic subtest: pipe-B-eDP-1 [597.969984] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [597.978946] Starting dynamic subtest: pipe-C-eDP-1 [598.000485] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [598.009132] Starting dynamic subtest: pipe-D-eDP-1 [598.031797] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [598.035957] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [600.131798] [093/133] (426s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [600.229156] Starting subtest: yf-tiled-16bpp-rotate-270 [600.234246] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [600.330617] [094/133] (425s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [600.399027] Starting subtest: multi-wait-available-unsubmitted-signaled [600.401646] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [600.491366] [095/133] (425s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [600.579151] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [600.584952] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [600.685450] [096/133] (425s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [600.778929] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [600.790024] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s) [600.890147] [097/133] (425s left) kms_psr (fbc-pr-sprite-render) [600.978775] Starting subtest: fbc-pr-sprite-render [600.983774] Subtest fbc-pr-sprite-render: SKIP (0.000s) [601.065424] [098/133] (425s left) kms_draw_crc (draw-method-mmap-wc) [601.163608] Starting subtest: draw-method-mmap-wc [601.165440] Starting dynamic subtest: xrgb8888-untiled [601.439228] Dynamic subtest xrgb8888-untiled: SUCCESS (0.277s) [601.451497] Starting dynamic subtest: rgb565-untiled [601.671812] Dynamic subtest rgb565-untiled: SUCCESS (0.230s) [601.681044] Starting dynamic subtest: xrgb2101010-untiled [601.893585] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [601.904571] Starting dynamic subtest: xbgr16161616f-untiled [602.115503] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [602.124842] Starting dynamic subtest: xrgb8888-xtiled [602.259211] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s) [602.271494] Starting dynamic subtest: rgb565-xtiled [602.392254] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [602.402329] Starting dynamic subtest: xrgb2101010-xtiled [602.514131] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s) [602.524057] Starting dynamic subtest: xbgr16161616f-xtiled [602.647117] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s) [602.656948] Starting dynamic subtest: xrgb8888-4tiled [602.804124] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s) [602.813540] Starting dynamic subtest: rgb565-4tiled [602.957875] Dynamic subtest rgb565-4tiled: SUCCESS (0.153s) [602.967070] Starting dynamic subtest: xrgb2101010-4tiled [603.102046] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s) [603.111601] Starting dynamic subtest: xbgr16161616f-4tiled [603.278849] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s) [603.281094] Subtest draw-method-mmap-wc: SUCCESS (2.123s) [603.360879] [099/133] (423s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [603.459273] Starting subtest: crc-primary-suspend-yf-tiled-ccs [603.461602] Starting dynamic subtest: pipe-A-eDP-1 [603.469357] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [603.479415] Starting dynamic subtest: pipe-B-eDP-1 [603.487553] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [603.496601] Starting dynamic subtest: pipe-C-eDP-1 [603.504128] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [603.513191] Starting dynamic subtest: pipe-D-eDP-1 [603.521986] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [603.526027] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [605.785891] [100/133] (420s left) kms_rotation_crc (primary-rotation-180) [605.877392] Starting subtest: primary-rotation-180 [612.924750] Subtest primary-rotation-180: SUCCESS (7.058s) [614.135621] [101/133] (412s left) kms_properties (get_properties-sanity-atomic) [614.218697] Starting subtest: get_properties-sanity-atomic [614.221213] Subtest get_properties-sanity-atomic: SUCCESS (0.003s) [614.293076] [102/133] (412s left) i915_pm_sseu (full-enable) [614.362324] Subtest full-enable: SKIP (0.000s) [614.452031] [103/133] (412s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [614.546805] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [614.551819] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [614.634528] [104/133] (411s left) gem_exec_big (single) [614.702258] Starting subtest: single [619.585792] Subtest single: SUCCESS (4.888s) [619.841681] [105/133] (406s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [619.994049] Starting subtest: psr-rgb565-draw-mmap-cpu [626.900102] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.912s) [627.013454] [106/133] (399s left) kms_pm_rpm (package-g7) [628.691155] Starting subtest: package-g7 [628.697113] Subtest package-g7: SKIP (0.000s) [629.301995] [107/133] (397s left) prime_vgem (coherency-gtt) [629.387205] Starting subtest: coherency-gtt [629.393035] Subtest coherency-gtt: SKIP (0.000s) [629.484011] [108/133] (397s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [629.581855] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [636.207140] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.629s) [636.345583] [109/133] (390s left) syncobj_basic (bad-flags-fd-to-handle) [636.414659] Starting subtest: bad-flags-fd-to-handle [636.417798] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [636.511267] [110/133] (390s left) perf (per-context-mode-unprivileged) [636.621447] Starting subtest: per-context-mode-unprivileged [636.626471] Subtest per-context-mode-unprivileged: SKIP (0.000s) [636.664574] [111/133] (390s left) kms_vblank (crtc-id) [636.753075] Starting subtest: crtc-id [636.755463] Starting dynamic subtest: pipe-A-eDP-1 [637.202981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s) [637.220188] Starting dynamic subtest: pipe-D-eDP-1 [638.357564] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.152s) [638.360061] Subtest crtc-id: SUCCESS (1.606s) [639.206891] [112/133] (387s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [639.332954] Starting subtest: cursorB-vs-flipA-toggle [639.338101] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s) [639.479236] [113/133] (387s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [639.569953] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [639.572812] Starting dynamic subtest: pipe-A-default-mode [642.331219] Dynamic subtest pipe-A-default-mode: SUCCESS (2.763s) [642.334119] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.764s) [643.202603] [114/133] (383s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [643.299986] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [643.305452] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [643.404520] [115/133] (383s left) gem_flink_basic (bad-open) [643.461046] Starting subtest: bad-open [643.463788] Subtest bad-open: SUCCESS (0.000s) [643.558092] [116/133] (383s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [643.619030] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [643.722112] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.101s) [643.800810] [117/133] (383s left) gem_exec_params (larger-than-life-batch) [643.863900] Starting subtest: larger-than-life-batch [645.929933] Subtest larger-than-life-batch: SUCCESS (2.068s) [646.631627] [118/133] (380s left) kms_plane (pixel-format-y-tiled-modifier) [646.779032] Starting subtest: pixel-format-y-tiled-modifier [646.784089] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s) [646.850991] [119/133] (380s left) kms_big_fb (yf-tiled-addfb) [646.952680] Starting subtest: yf-tiled-addfb [646.957903] Subtest yf-tiled-addfb: SKIP (0.000s) [647.033452] [120/133] (380s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [647.129716] Starting subtest: primary-4-tiled-reflect-x-0 [654.269932] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.149s) [655.471527] [121/133] (371s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [655.563777] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [662.318205] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.763s) [662.431204] [122/133] (364s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [662.527641] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [662.532937] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [662.643642] [123/133] (364s left) kms_plane_alpha_blend (alpha-7efc) [662.733317] Starting subtest: alpha-7efc [663.034390] Starting dynamic subtest: pipe-A-eDP-1 [663.668005] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s) [663.697526] Starting dynamic subtest: pipe-D-eDP-1 [664.979986] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.292s) [664.983030] Subtest alpha-7efc: SUCCESS (2.250s) [665.833736] [124/133] (361s left) api_intel_bb (simple-bb) [665.889457] Starting subtest: simple-bb [665.893747] Subtest simple-bb: SUCCESS (0.007s) [666.024357] [125/133] (361s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [666.119262] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [666.123999] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [666.241857] [126/133] (361s left) sw_sync (alloc_fence_invalid_timeline) [666.290229] Starting subtest: alloc_fence_invalid_timeline [666.293259] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [666.354777] [127/133] (361s left) gem_exec_balancer (bonded-semaphore) [666.427233] Starting subtest: bonded-semaphore [666.432272] Subtest bonded-semaphore: SKIP (0.000s) [666.729408] [128/133] (360s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [666.826096] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [666.828806] Starting dynamic subtest: pipe-A-eDP-1 [677.822118] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.005s) [677.833204] Starting dynamic subtest: pipe-B-eDP-1 [689.567065] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.749s) [689.569269] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.756s) [690.383802] [129/133] (337s left) gem_ctx_engines (execute-one) [690.447001] Starting subtest: execute-one [692.611439] Subtest execute-one: SUCCESS (2.166s) [692.797287] [130/133] (334s left) gem_tiled_pread_basic (basic) [692.856131] Subtest basic: SKIP (0.000s) [692.919053] [131/133] (334s left) kms_async_flips (invalid-async-flip) [693.011597] Starting subtest: invalid-async-flip [693.397951] Starting dynamic subtest: pipe-A-eDP-1 [694.214888] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.817s) [694.572104] Starting dynamic subtest: pipe-B-eDP-1 [695.345865] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.782s) [695.705658] Starting dynamic subtest: pipe-C-eDP-1 [696.463124] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s) [696.831108] Starting dynamic subtest: pipe-D-eDP-1 [697.595777] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s) [697.598236] Subtest invalid-async-flip: SUCCESS (4.580s) [698.755997] [132/133] (329s left) gen9_exec_parse (secure-batches) [698.817004] Subtest secure-batches: SKIP (0.000s) [698.889420] [133/133] (328s left) gem_linear_blits (interruptible) [699.085475] Starting subtest: interruptible [703.756216] Subtest interruptible: SUCCESS (4.668s) [703.926759] Closing watchdogs results: parsing output: 0/ for test: gem_mmap_wc results: parsing output: 1/ for test: kms_setmode results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: gem_ctx_persistence results: parsing output: 4/ for test: kms_pm_backlight results: parsing output: 5/ for test: kms_psr results: parsing output: 6/ for test: kms_ccs results: parsing output: 7/ for test: gem_mmap_gtt results: parsing output: 8/ for test: sysfs_timeslice_duration results: parsing output: 9/ for test: gem_eio results: parsing output: 10/ for test: gem_exec_schedule results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: gem_ctx_persistence results: parsing output: 13/ for test: kms_psr results: parsing output: 14/ for test: perf_pmu results: parsing output: 15/ for test: kms_plane_cursor results: parsing output: 16/ for test: kms_async_flips results: parsing output: 17/ for test: kms_cursor_crc results: parsing output: 18/ for test: kms_psr2_sf results: parsing output: 19/ for test: gem_spin_batch results: parsing output: 20/ for test: gem_eio results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: syncobj_timeline results: parsing output: 23/ for test: core_getversion results: parsing output: 24/ for test: kms_fbcon_fbt results: parsing output: 25/ for test: kms_universal_plane results: parsing output: 26/ for test: gem_exec_fence results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: kms_rmfb results: parsing output: 30/ for test: gem_mmap_wc results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_prop_blob results: parsing output: 34/ for test: gem_busy results: parsing output: 35/ for test: kms_atomic_interruptible results: parsing output: 36/ for test: kms_cursor_edge_walk results: parsing output: 37/ for test: gem_eio results: parsing output: 38/ for test: kms_pm_rpm results: parsing output: 39/ for test: gem_partial_pwrite_pread results: parsing output: 40/ for test: syncobj_timeline results: parsing output: 41/ for test: syncobj_wait results: parsing output: 42/ for test: gem_mmap_wc results: parsing output: 43/ for test: gem_exec_schedule results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_color results: parsing output: 46/ for test: kms_setmode results: parsing output: 47/ for test: gem_exec_suspend results: parsing output: 48/ for test: kms_content_protection results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_mmap results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_flip results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_cursor_legacy results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_ccs results: parsing output: 57/ for test: kms_pipe_b_c_ivb results: parsing output: 58/ for test: gem_exec_reloc results: parsing output: 59/ for test: kms_invalid_mode results: parsing output: 60/ for test: kms_lease results: parsing output: 61/ for test: kms_cursor_crc results: parsing output: 62/ for test: perf_pmu results: parsing output: 63/ for test: gem_render_copy results: parsing output: 64/ for test: i915_drm_fdinfo results: parsing output: 65/ for test: kms_chamelium_hpd results: parsing output: 66/ for test: gem_userptr_blits results: parsing output: 67/ for test: gem_ctx_shared results: parsing output: 68/ for test: perf_pmu results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: gem_huc_copy results: parsing output: 72/ for test: gem_render_copy results: parsing output: 73/ for test: i915_drm_fdinfo results: parsing output: 74/ for test: i915_pm_rps results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: syncobj_wait results: parsing output: 78/ for test: gem_mmap_wc results: parsing output: 79/ for test: kms_vblank results: parsing output: 80/ for test: kms_plane results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: gem_exec_reloc results: parsing output: 83/ for test: kms_flip_tiling results: parsing output: 84/ for test: kms_hdr results: parsing output: 85/ for test: kms_chamelium_edid results: parsing output: 86/ for test: perf results: parsing output: 87/ for test: kms_flip results: parsing output: 88/ for test: api_intel_bb results: parsing output: 89/ for test: gem_render_copy_redux results: parsing output: 90/ for test: gem_partial_pwrite_pread results: parsing output: 91/ for test: kms_ccs results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: syncobj_timeline results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_flip results: parsing output: 96/ for test: kms_psr results: parsing output: 97/ for test: kms_draw_crc results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: kms_rotation_crc results: parsing output: 100/ for test: kms_properties results: parsing output: 101/ for test: i915_pm_sseu results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_exec_big results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_pm_rpm results: parsing output: 106/ for test: prime_vgem results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: syncobj_basic results: parsing output: 109/ for test: perf results: parsing output: 110/ for test: kms_vblank results: parsing output: 111/ for test: kms_cursor_legacy results: parsing output: 112/ for test: kms_flip_scaled_crc results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_flink_basic results: parsing output: 115/ for test: syncobj_timeline results: parsing output: 116/ for test: gem_exec_params results: parsing output: 117/ for test: kms_plane results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: kms_rotation_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_plane_alpha_blend results: parsing output: 123/ for test: api_intel_bb results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: sw_sync results: parsing output: 126/ for test: gem_exec_balancer results: parsing output: 127/ for test: kms_psr2_sf results: parsing output: 128/ for test: gem_ctx_engines results: parsing output: 129/ for test: gem_tiled_pread_basic results: parsing output: 130/ for test: kms_async_flips results: parsing output: 131/ for test: gen9_exec_parse results: parsing output: 132/ for test: gem_linear_blits Done.