[60.039172] Initializing watchdogs [60.039308] /dev/watchdog0 [60.055693] [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.060427] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.063080] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.066658] [001/156] (960s left) kms_psr (psr-sprite-mmap-cpu) [60.194833] Starting subtest: psr-sprite-mmap-cpu [60.197096] Starting dynamic subtest: eDP-1 [62.011022] Dynamic subtest eDP-1: SUCCESS (1.789s) [62.013385] Subtest psr-sprite-mmap-cpu: SUCCESS (1.790s) [62.878790] [002/156] (957s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip) [62.998391] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip [63.002675] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [63.094305] [003/156] (957s left) kms_psr (psr2-cursor-mmap-gtt) [63.193213] Starting subtest: psr2-cursor-mmap-gtt [63.195641] Starting dynamic subtest: eDP-1 [64.980283] Dynamic subtest eDP-1: SUCCESS (1.771s) [64.982770] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.771s) [65.858602] [004/156] (954s left) kms_chamelium_edid (hdmi-edid-read) [66.257898] Subtest hdmi-edid-read: SKIP (0.000s) [67.075203] [005/156] (953s left) i915_drm_fdinfo (busy-idle) [67.121076] Starting subtest: busy-idle [67.123511] Starting dynamic subtest: rcs0 [67.141689] Dynamic subtest rcs0: SKIP (0.018s) [67.150152] Starting dynamic subtest: bcs0 [67.154321] Dynamic subtest bcs0: SKIP (0.000s) [67.162042] Starting dynamic subtest: vcs0 [67.166419] Dynamic subtest vcs0: SKIP (0.000s) [67.173786] Starting dynamic subtest: vcs1 [67.178303] Dynamic subtest vcs1: SKIP (0.000s) [67.185766] Starting dynamic subtest: vecs0 [67.190235] Dynamic subtest vecs0: SKIP (0.000s) [67.197738] Starting dynamic subtest: ccs0 [67.202290] Dynamic subtest ccs0: SKIP (0.000s) [67.206900] Subtest busy-idle: SKIP (0.021s) [67.242171] [006/156] (953s left) kms_vrr (flip-basic) [67.343109] Starting subtest: flip-basic [67.349602] Subtest flip-basic: SKIP (0.000s) [67.424697] [007/156] (953s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt) [67.531929] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt [67.535905] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [67.640649] [008/156] (953s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [67.741973] Starting subtest: yf-tiled-32bpp-rotate-90 [67.746326] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [67.859934] [009/156] (953s left) gem_close_race (basic-process) [67.920530] Starting subtest: basic-process [67.965791] Subtest basic-process: SUCCESS (0.044s) [68.147965] [010/156] (952s left) kms_flip (bo-too-big-interruptible) [68.247221] Starting subtest: bo-too-big-interruptible [68.249588] Starting dynamic subtest: A-eDP1 [69.564207] Dynamic subtest A-eDP1: SUCCESS (1.309s) [69.572827] Starting dynamic subtest: B-eDP1 [70.900660] Dynamic subtest B-eDP1: SUCCESS (1.329s) [70.911129] Starting dynamic subtest: C-eDP1 [72.235049] Dynamic subtest C-eDP1: SUCCESS (1.330s) [72.245678] Starting dynamic subtest: D-eDP1 [73.578646] Dynamic subtest D-eDP1: SUCCESS (1.338s) [73.583865] Subtest bo-too-big-interruptible: SUCCESS (5.314s) [74.793317] [011/156] (946s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [74.892881] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [74.897202] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [74.970884] [012/156] (946s left) syncobj_wait (single-wait-all-signaled) [75.034089] Starting subtest: single-wait-all-signaled [75.036535] Subtest single-wait-all-signaled: SUCCESS (0.000s) [75.139779] [013/156] (945s left) perf_pmu (interrupts) [75.181887] Starting subtest: interrupts [76.284488] Subtest interrupts: SUCCESS (1.098s) [76.396382] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true [76.399838] [014/156] (944s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [76.496828] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [83.435682] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.936s) [83.589850] [015/156] (937s left) gem_mmap (big-bo) [83.651127] Subtest big-bo: SKIP (0.000s) [83.707277] [016/156] (937s left) kms_rotation_crc (cursor-rotation-180) [83.797824] Starting subtest: cursor-rotation-180 [85.297416] Subtest cursor-rotation-180: SUCCESS (1.499s) [86.494198] [017/156] (934s left) kms_lease (possible-crtcs-filtering) [86.586213] Starting subtest: possible-crtcs-filtering [86.593617] Subtest possible-crtcs-filtering: SUCCESS (0.007s) [86.705938] [018/156] (934s left) gem_busy (busy) [86.763278] Starting subtest: busy [86.765652] Starting dynamic subtest: all-engines [86.828799] Dynamic subtest all-engines: SUCCESS (0.066s) [86.838093] Starting dynamic subtest: rcs0 [88.326956] Dynamic subtest rcs0: SUCCESS (1.495s) [88.337805] Starting dynamic subtest: bcs0 [88.375165] Dynamic subtest bcs0: SUCCESS (0.047s) [88.385134] Starting dynamic subtest: vcs0 [88.411059] Dynamic subtest vcs0: SUCCESS (0.037s) [88.422828] Starting dynamic subtest: vcs1 [90.306699] Dynamic subtest vcs1: SUCCESS (1.892s) [90.315534] Starting dynamic subtest: vecs0 [92.293525] Dynamic subtest vecs0: SUCCESS (1.982s) [92.303347] Starting dynamic subtest: ccs0 [94.278118] Dynamic subtest ccs0: SUCCESS (1.982s) [94.280327] Subtest busy: SUCCESS (7.505s) [94.653679] [019/156] (926s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [94.747827] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [94.750340] Starting dynamic subtest: pipe-A-eDP-1 [94.774077] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [94.785372] Starting dynamic subtest: pipe-B-eDP-1 [94.807360] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [94.815590] Starting dynamic subtest: pipe-C-eDP-1 [94.837328] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [94.845697] Starting dynamic subtest: pipe-D-eDP-1 [94.867797] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [94.872811] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.004s) [97.049256] [020/156] (924s left) kms_chamelium_hpd (common-hpd-after-suspend) [97.427520] Subtest common-hpd-after-suspend: SKIP (0.000s) [98.248198] [021/156] (923s left) api_intel_bb (blit-noreloc-purge-cache) [98.301905] Starting subtest: blit-noreloc-purge-cache [98.310542] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s) [98.439249] [022/156] (923s left) gem_spin_batch (legacy-resubmit-new) [98.503635] Starting subtest: legacy-resubmit-new [98.505950] Starting dynamic subtest: default [98.510996] Dynamic subtest default: SUCCESS (0.007s) [98.522285] Starting dynamic subtest: render [98.524361] Dynamic subtest render: SUCCESS (0.004s) [98.536705] Starting dynamic subtest: bsd [98.538975] Dynamic subtest bsd: SUCCESS (0.005s) [98.547589] Starting dynamic subtest: bsd1 [98.549455] Dynamic subtest bsd1: SUCCESS (0.005s) [98.557672] Starting dynamic subtest: bsd2 [98.559583] Dynamic subtest bsd2: SUCCESS (0.004s) [98.567613] Starting dynamic subtest: blt [98.569476] Dynamic subtest blt: SUCCESS (0.005s) [98.578569] Starting dynamic subtest: vebox [98.580640] Dynamic subtest vebox: SUCCESS (0.004s) [98.582689] Subtest legacy-resubmit-new: SUCCESS (0.037s) [100.330423] [023/156] (921s left) kms_dp_link_training (uhbr-mst) [100.426672] Starting subtest: uhbr-mst [100.435303] Subtest uhbr-mst: SKIP (0.000s) [100.501734] [024/156] (921s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [100.604570] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [100.608977] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [100.696998] [025/156] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [100.796243] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [100.800780] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [100.887101] [026/156] (920s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [100.989565] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu [100.993804] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [101.074812] [027/156] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [101.174122] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [107.936512] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.765s) [108.063603] [028/156] (913s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [108.156467] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [108.158840] Starting dynamic subtest: pipe-A-eDP-1 [108.182346] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [108.193358] Starting dynamic subtest: pipe-B-eDP-1 [108.214703] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [108.223211] Starting dynamic subtest: pipe-C-eDP-1 [108.244945] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [108.255331] Starting dynamic subtest: pipe-D-eDP-1 [108.276658] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [108.280648] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s) [110.448691] [029/156] (911s left) syncobj_wait (wait-any-complex) [110.505010] Starting subtest: wait-any-complex [110.566050] Subtest wait-any-complex: SUCCESS (0.062s) [110.655300] [030/156] (911s left) syncobj_basic (test-valid-cycle) [110.707239] Starting subtest: test-valid-cycle [110.709539] Subtest test-valid-cycle: SUCCESS (0.000s) [110.807045] [031/156] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [110.916170] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [110.920305] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [111.017247] [032/156] (910s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [111.120409] Starting subtest: planes-downscale-factor-0-75-unity-scaling [111.122757] Starting dynamic subtest: pipe-A [111.183767] Dynamic subtest pipe-A: SUCCESS (0.065s) [111.196948] Starting dynamic subtest: pipe-B [112.380753] Dynamic subtest pipe-B: SUCCESS (1.195s) [112.392394] Starting dynamic subtest: pipe-C [113.495687] Dynamic subtest pipe-C: SUCCESS (1.114s) [113.504330] Starting dynamic subtest: pipe-D [114.641715] Dynamic subtest pipe-D: SUCCESS (1.145s) [114.643959] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.523s) [115.796014] [033/156] (906s left) gem_mmap_gtt (medium-copy-xy) [115.854369] Subtest medium-copy-XY: SKIP (0.000s) [115.917389] [034/156] (906s left) kms_cursor_crc (cursor-sliding-32x10) [116.076103] Starting subtest: cursor-sliding-32x10 [116.127111] Subtest cursor-sliding-32x10: SKIP (0.046s) [116.394250] [035/156] (905s left) syncobj_timeline (multi-wait-signaled) [116.460109] Starting subtest: multi-wait-signaled [116.462459] Subtest multi-wait-signaled: SUCCESS (0.001s) [116.573154] [036/156] (905s left) i915_pm_rps (thresholds) [116.640766] Starting subtest: thresholds [116.644817] Subtest thresholds: SKIP (0.001s) [116.732695] [037/156] (905s left) kms_psr (psr-cursor-render) [116.822868] Starting subtest: psr-cursor-render [116.824862] Starting dynamic subtest: eDP-1 [118.594109] Dynamic subtest eDP-1: SUCCESS (1.770s) [118.596280] Subtest psr-cursor-render: SUCCESS (1.771s) [119.465838] [038/156] (902s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [119.580299] Starting subtest: psr2-overlay-plane-move-continuous-sf [119.582786] Starting dynamic subtest: pipe-A-eDP-1 [125.575782] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.995s) [125.587467] Starting dynamic subtest: pipe-B-eDP-1 [132.258068] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.682s) [132.260388] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.680s) [133.121087] [039/156] (889s left) vgem_basic (dmabuf-mmap) [133.164213] Starting subtest: dmabuf-mmap [133.175081] Subtest dmabuf-mmap: SUCCESS (0.013s) [133.235534] [040/156] (888s left) core_setmaster (master-drop-set-user) [133.309235] Starting subtest: master-drop-set-user [133.319984] Subtest master-drop-set-user: SUCCESS (0.013s) [133.361314] [041/156] (888s left) kms_big_fb (y-tiled-16bpp-rotate-0) [133.469628] Starting subtest: y-tiled-16bpp-rotate-0 [133.473976] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [133.556837] [042/156] (888s left) gem_fence_thrash (bo-write-verify-x) [133.592402] Starting subtest: bo-write-verify-x [133.617288] Subtest bo-write-verify-x: SKIP (0.024s) [133.682547] [043/156] (888s left) gem_set_tiling_vs_gtt [133.799796] [044/156] (888s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [133.893399] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [133.895708] Starting dynamic subtest: pipe-A-eDP-1 [134.653579] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.753s) [134.664979] Starting dynamic subtest: pipe-B-eDP-1 [136.477955] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.823s) [136.489100] Starting dynamic subtest: pipe-C-eDP-1 [138.292765] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.814s) [138.302817] Starting dynamic subtest: pipe-D-eDP-1 [140.124301] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.829s) [140.126264] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.224s) [141.360597] [045/156] (881s left) kms_frontbuffer_tracking (fbchdr-tiling-linear) [141.464744] Starting subtest: fbchdr-tiling-linear [141.469271] Subtest fbchdr-tiling-linear: SKIP (0.000s) [141.562794] [046/156] (880s left) template (b) [141.619430] Starting subtest: B [141.621966] Subtest B: SUCCESS (0.000s) [141.705481] [047/156] (880s left) kms_psr (fbc-psr2-cursor-blt) [141.800970] Starting subtest: fbc-psr2-cursor-blt [141.803295] Starting dynamic subtest: eDP-1 [141.807353] Dynamic subtest eDP-1: SKIP (0.000s) [141.811494] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [141.881867] [048/156] (880s left) prime_vgem (basic-fence-blt) [141.941717] Starting subtest: basic-fence-blt [142.024088] Subtest basic-fence-blt: SUCCESS (0.082s) [142.143759] [049/156] (880s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-pwrite) [142.240803] Starting subtest: psrhdr-rgb565-draw-pwrite [142.244988] Subtest psrhdr-rgb565-draw-pwrite: SKIP (0.000s) [142.355938] [050/156] (880s left) gem_workarounds (suspend-resume) [142.419674] Starting subtest: suspend-resume [158.202693] Subtest suspend-resume: SUCCESS (1.298s) [158.331962] [051/156] (864s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling) [158.440915] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling [158.445010] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s) [158.514273] [052/156] (864s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [158.607064] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [158.611709] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [158.708268] [053/156] (864s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [158.808214] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [158.812731] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [158.911033] [054/156] (863s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [159.015162] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-gtt [159.019993] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [159.115448] [055/156] (863s left) kms_big_fb (4-tiled-32bpp-rotate-270) [159.227270] Starting subtest: 4-tiled-32bpp-rotate-270 [159.248071] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.021s) [159.379580] [056/156] (863s left) gem_userptr_blits (sync-unmap-after-close) [159.445968] Starting subtest: sync-unmap-after-close [159.462441] Subtest sync-unmap-after-close: SUCCESS (0.013s) [159.592884] [057/156] (863s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [160.142331] Starting subtest: syncobj-timeline-multiple-ext-nodes [160.144966] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s) [161.889797] [058/156] (861s left) gem_sync (basic-each) [161.968677] Starting subtest: basic-each [164.546205] Subtest basic-each: SUCCESS (2.522s) [164.735155] [059/156] (858s left) gem_mmap (bad-offset) [164.788762] Subtest bad-offset: SKIP (0.000s) [164.854331] [060/156] (858s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [164.951213] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [164.955903] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [166.136217] [061/156] (856s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render) [166.246518] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render [166.250901] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [166.352814] [062/156] (856s left) kms_vblank (query-forked-hang) [166.457992] Starting subtest: query-forked-hang [166.459951] Starting dynamic subtest: pipe-A-eDP-1 [192.541222] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.950s) [192.555644] Starting dynamic subtest: pipe-D-eDP-1 [207.515412] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.963s) [207.517521] Subtest query-forked-hang: SUCCESS (40.917s) [208.334806] [063/156] (814s left) gem_exec_schedule (u-fairslice-all) [208.404350] Starting subtest: u-fairslice-all [210.511931] Subtest u-fairslice-all: SUCCESS (2.061s) [211.800866] [064/156] (811s left) perf_pmu (busy-no-semaphores) [211.840712] Starting subtest: busy-no-semaphores [211.843179] Starting dynamic subtest: rcs0 [212.409107] Dynamic subtest rcs0: SUCCESS (0.567s) [212.420172] Starting dynamic subtest: bcs0 [212.961121] Dynamic subtest bcs0: SUCCESS (0.549s) [212.973587] Starting dynamic subtest: vcs0 [213.512896] Dynamic subtest vcs0: SUCCESS (0.548s) [213.525772] Starting dynamic subtest: vcs1 [215.312987] Dynamic subtest vcs1: SUCCESS (1.797s) [215.325393] Starting dynamic subtest: vecs0 [217.297480] Dynamic subtest vecs0: SUCCESS (1.981s) [217.308750] Starting dynamic subtest: ccs0 [219.281463] Dynamic subtest ccs0: SUCCESS (1.980s) [219.284350] Subtest busy-no-semaphores: SUCCESS (7.437s) [219.399596] [065/156] (803s left) kms_cursor_crc (cursor-offscreen-32x32) [219.548907] Starting subtest: cursor-offscreen-32x32 [219.600105] Subtest cursor-offscreen-32x32: SKIP (0.047s) [219.886983] [066/156] (803s left) kms_invalid_mode (uint-max-clock) [219.986874] Starting subtest: uint-max-clock [219.989058] Starting dynamic subtest: pipe-A-eDP-1 [220.277043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s) [220.288551] Starting dynamic subtest: pipe-B-eDP-1 [220.290531] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [220.300340] Starting dynamic subtest: pipe-C-eDP-1 [220.302611] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [220.312221] Starting dynamic subtest: pipe-D-eDP-1 [220.314189] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [220.316276] Subtest uint-max-clock: SUCCESS (0.294s) [221.079374] [067/156] (802s left) sw_sync (sync_multi_consumer) [221.118019] Starting subtest: sync_multi_consumer [221.542122] Subtest sync_multi_consumer: SUCCESS (0.424s) [221.604602] [068/156] (801s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [221.657402] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [221.659280] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [221.759475] [069/156] (801s left) core_auth (getclient-simple) [221.797792] Starting subtest: getclient-simple [221.815048] Subtest getclient-simple: SUCCESS (0.018s) [221.930747] [070/156] (801s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt) [222.027499] Starting subtest: psrhdr-rgb565-draw-blt [222.031959] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s) [222.120969] [071/156] (801s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [222.238976] Starting subtest: cursor-vs-flip-atomic-transitions [252.572210] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.315s) [253.427207] [072/156] (770s left) perf_pmu (rc6-all-gts) [253.469126] Starting subtest: rc6-all-gts [259.891506] Subtest rc6-all-gts: SUCCESS (6.377s) [260.749386] [073/156] (762s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [260.863094] Starting subtest: fbc-rgb101010-draw-blt [263.326459] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.473s) [264.540011] [074/156] (759s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt) [264.636661] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt [264.640765] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [264.757380] [075/156] (758s left) gem_exec_suspend (basic-s3) [264.812475] Starting subtest: basic-S3 [264.814830] Starting dynamic subtest: smem [285.137504] Dynamic subtest smem: SUCCESS (6.883s) [285.140618] Subtest basic-S3: SUCCESS (6.886s) [285.330774] [076/156] (738s left) gem_exec_schedule (wide) [285.513959] Starting subtest: wide [285.516317] Starting dynamic subtest: rcs0 [297.131734] Dynamic subtest rcs0: SUCCESS (11.341s) [297.145693] Starting dynamic subtest: vcs0 [308.595342] Dynamic subtest vcs0: SUCCESS (11.462s) [308.609911] Starting dynamic subtest: vcs1 [318.802049] Dynamic subtest vcs1: SUCCESS (10.190s) [318.813918] Starting dynamic subtest: vecs0 [330.442840] Dynamic subtest vecs0: SUCCESS (11.634s) [330.458027] Starting dynamic subtest: ccs0 [343.740797] Dynamic subtest ccs0: SUCCESS (13.238s) [343.743069] Subtest wide: SUCCESS (57.871s) [345.719244] [077/156] (678s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [345.828255] Starting subtest: psr-modesetfrombusy [352.140962] Subtest psr-modesetfrombusy: SUCCESS (6.318s) [352.304631] [078/156] (671s left) syncobj_timeline (32bits-limit) [352.355130] Starting subtest: 32bits-limit [352.357084] Subtest 32bits-limit: SUCCESS (0.001s) [352.450926] [079/156] (671s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [352.553405] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [352.557002] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [352.655877] [080/156] (671s left) gem_wait (busy) [352.706516] Starting subtest: busy [352.708713] Starting dynamic subtest: all-engines [354.126963] Dynamic subtest all-engines: SUCCESS (1.418s) [354.146651] Starting dynamic subtest: rcs0 [354.667483] Dynamic subtest rcs0: SUCCESS (0.539s) [354.681244] Starting dynamic subtest: bcs0 [355.207358] Dynamic subtest bcs0: SUCCESS (0.539s) [355.218381] Starting dynamic subtest: vcs0 [357.136581] Dynamic subtest vcs0: SUCCESS (1.925s) [357.150250] Starting dynamic subtest: vcs1 [359.183578] Dynamic subtest vcs1: SUCCESS (2.043s) [359.196465] Starting dynamic subtest: vecs0 [361.168529] Dynamic subtest vecs0: SUCCESS (1.981s) [361.181766] Starting dynamic subtest: ccs0 [361.711233] Dynamic subtest ccs0: SUCCESS (0.541s) [361.714016] Subtest busy: SUCCESS (9.000s) [361.905384] [081/156] (662s left) kms_prop_blob (blob-multiple) [361.954942] Starting subtest: blob-multiple [361.957346] Subtest blob-multiple: SUCCESS (0.003s) [362.060453] [082/156] (661s left) gem_exec_schedule (lateslice) [362.124585] Starting subtest: lateslice [362.126503] Starting dynamic subtest: rcs0 [362.143275] Dynamic subtest rcs0: SUCCESS (0.027s) [362.166714] Starting dynamic subtest: bcs0 [362.172547] Dynamic subtest bcs0: SUCCESS (0.029s) [362.182848] Starting dynamic subtest: vcs0 [362.196082] Dynamic subtest vcs0: SUCCESS (0.022s) [362.206234] Starting dynamic subtest: vcs1 [362.218670] Dynamic subtest vcs1: SUCCESS (0.022s) [362.228560] Starting dynamic subtest: vecs0 [362.243226] Dynamic subtest vecs0: SUCCESS (0.024s) [362.253565] Starting dynamic subtest: ccs0 [362.269703] Dynamic subtest ccs0: SUCCESS (0.025s) [362.271915] Subtest lateslice: SUCCESS (0.154s) [364.268202] [083/156] (659s left) gem_mmap_gtt (basic-read-write-distinct) [364.329404] Subtest basic-read-write-distinct: SKIP (0.000s) [364.399289] [084/156] (659s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-move) [364.508908] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-move [364.513745] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [364.612668] [085/156] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [364.721886] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [364.725965] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [364.825154] [086/156] (659s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move) [364.935250] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move [364.939419] Subtest fbchdr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [365.019803] [087/156] (659s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [365.121142] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [369.586046] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.468s) [370.732063] [088/156] (653s left) gem_exec_params (invalid-fence-in) [370.788574] Starting subtest: invalid-fence-in [370.790784] Subtest invalid-fence-in: SUCCESS (0.000s) [370.896900] [089/156] (653s left) gem_exec_balancer (invalid-balancer) [370.949845] Starting subtest: invalid-balancer [371.907452] Subtest invalid-balancer: SUCCESS (0.955s) [372.221753] [090/156] (652s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [372.323763] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [377.307514] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.987s) [378.532641] [091/156] (645s left) syncobj_timeline (invalid-transfer-illegal-handle) [378.595929] Starting subtest: invalid-transfer-illegal-handle [378.597907] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [378.690070] [092/156] (645s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [378.782581] Starting subtest: nonblocking-crc-frame-sequence [378.784793] Starting dynamic subtest: pipe-A-eDP-1 [379.538962] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.756s) [379.551692] Starting dynamic subtest: pipe-B-eDP-1 [380.943821] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s) [380.955445] Starting dynamic subtest: pipe-C-eDP-1 [382.323468] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s) [382.334776] Starting dynamic subtest: pipe-D-eDP-1 [383.753110] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.426s) [383.755135] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.971s) [384.636565] [093/156] (639s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [384.740208] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc [384.744359] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [384.847577] [094/156] (639s left) vgem_basic (second-client) [384.887770] Starting subtest: second-client [384.907892] Subtest second-client: SUCCESS (0.022s) [384.990759] [095/156] (639s left) gem_exec_reloc (basic-range-active) [385.046815] Subtest basic-range-active: SKIP (0.000s) [385.119383] [096/156] (639s left) kms_color (ctm-0-75) [385.214400] Starting subtest: ctm-0-75 [385.216254] Starting dynamic subtest: pipe-A-eDP-1 [390.178868] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.967s) [390.195094] Starting dynamic subtest: pipe-B-eDP-1 [395.945161] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.768s) [395.957915] Starting dynamic subtest: pipe-C-eDP-1 [401.319788] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.372s) [401.331936] Starting dynamic subtest: pipe-D-eDP-1 [406.644980] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.326s) [406.647265] Subtest ctm-0-75: SUCCESS (21.437s) [407.472358] [097/156] (617s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [407.572582] Starting subtest: 2x-wf_vblank-ts-check-interruptible [407.584813] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [407.685284] [098/156] (617s left) gem_exec_schedule (smoketest-all) [407.757745] Starting subtest: smoketest-all [440.120862] Subtest smoketest-all: SUCCESS (32.321s) [441.273527] [099/156] (583s left) gem_ctx_exec (basic-nohangcheck) [441.325737] Starting subtest: basic-nohangcheck [441.666069] Subtest basic-nohangcheck: SUCCESS (0.341s) [441.785491] [100/156] (583s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [441.880064] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [441.882241] Starting dynamic subtest: pipe-A-eDP-1 [441.906083] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [441.918666] Starting dynamic subtest: pipe-B-eDP-1 [441.941383] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [441.950681] Starting dynamic subtest: pipe-C-eDP-1 [441.973945] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [441.983248] Starting dynamic subtest: pipe-D-eDP-1 [442.007187] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [442.011522] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [444.136690] [101/156] (580s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [444.243028] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [444.247193] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [444.340247] [102/156] (580s left) kms_big_fb (linear-32bpp-rotate-270) [444.439211] Starting subtest: linear-32bpp-rotate-270 [444.462403] Subtest linear-32bpp-rotate-270: SKIP (0.023s) [444.582729] [103/156] (580s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-pwrite) [444.696140] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-pwrite [444.700746] Subtest hdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [444.788404] [104/156] (580s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [444.912816] Starting subtest: cursorB-vs-flipB-atomic-transitions [444.917240] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [445.069999] [105/156] (579s left) gem_eio (wait-10ms) [445.301807] Starting subtest: wait-10ms [445.671865] Subtest wait-10ms: SUCCESS (0.368s) [445.828997] [106/156] (579s left) syncobj_timeline (wait-for-submit-delayed-submit) [445.882643] Starting subtest: wait-for-submit-delayed-submit [445.987423] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [446.085889] [107/156] (579s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [446.190668] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf [446.193028] Starting dynamic subtest: pipe-A-eDP-1 [446.264851] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s) [446.276844] Starting dynamic subtest: pipe-B-eDP-1 [447.416735] Dynamic subtest pipe-B-eDP-1: SKIP (1.147s) [447.421536] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.230s) [448.697946] [108/156] (576s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt) [448.799422] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt [448.803928] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [448.902377] [109/156] (576s left) sysfs_heartbeat_interval (precise) [448.951780] Starting subtest: precise [448.954225] Starting dynamic subtest: vecs0 [456.138217] Dynamic subtest vecs0: SUCCESS (7.181s) [456.153916] Starting dynamic subtest: ccs0 [457.264442] Dynamic subtest ccs0: SUCCESS (1.126s) [457.280444] Starting dynamic subtest: vcs0 [465.171970] Dynamic subtest vcs0: SUCCESS (7.900s) [465.184789] Starting dynamic subtest: bcs0 [466.268936] Dynamic subtest bcs0: SUCCESS (1.096s) [466.281733] Starting dynamic subtest: rcs0 [467.375076] Dynamic subtest rcs0: SUCCESS (1.106s) [467.386891] Starting dynamic subtest: vcs1 [475.164403] Dynamic subtest vcs1: SUCCESS (7.783s) [475.166794] Subtest precise: SUCCESS (26.204s) [475.245632] [110/156] (550s left) gen7_exec_parse (batch-without-end) [475.308308] Subtest batch-without-end: SKIP (0.000s) [475.396318] [111/156] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [475.501859] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [482.871024] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.372s) [483.024613] [112/156] (542s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [483.116396] Starting subtest: fbc-rgb565-draw-render [487.382022] Subtest fbc-rgb565-draw-render: SUCCESS (4.270s) [488.549447] [113/156] (536s left) i915_suspend (sysfs-reader) [488.614614] Starting subtest: sysfs-reader [506.163445] Subtest sysfs-reader: SUCCESS (3.069s) [506.217416] [114/156] (519s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-msflip-blt) [506.321453] Starting subtest: psrhdr-2p-primscrn-indfb-msflip-blt [506.325490] Subtest psrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [506.422208] [115/156] (519s left) kms_addfb_basic (bad-pitch-0) [506.481356] Starting subtest: bad-pitch-0 [506.483101] Subtest bad-pitch-0: SUCCESS (0.000s) [506.630930] [116/156] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [506.729871] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [506.733356] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [506.834668] [117/156] (518s left) kms_content_protection (lic-type-0) [506.974463] Starting subtest: lic-type-0 [506.978748] Subtest lic-type-0: SKIP (0.000s) [507.086078] [118/156] (518s left) gem_ctx_persistence (userptr) [507.151523] Starting subtest: userptr [507.321448] Subtest userptr: SUCCESS (0.163s) [507.404334] [119/156] (518s left) gem_render_copy (yf-tiled) [507.465232] Starting subtest: yf-tiled [507.469238] Subtest yf-tiled: SKIP (0.000s) [507.650138] [120/156] (518s left) gem_ctx_persistence (engines-cleanup) [507.715022] Starting subtest: engines-cleanup [507.717256] Starting dynamic subtest: rcs0 [507.782281] Dynamic subtest rcs0: SUCCESS (0.065s) [507.795294] Starting dynamic subtest: bcs0 [507.815998] Dynamic subtest bcs0: SUCCESS (0.031s) [507.826368] Starting dynamic subtest: vcs0 [507.854809] Dynamic subtest vcs0: SUCCESS (0.036s) [507.865880] Starting dynamic subtest: vcs1 [507.903033] Dynamic subtest vcs1: SUCCESS (0.044s) [507.914836] Starting dynamic subtest: vecs0 [507.969318] Dynamic subtest vecs0: SUCCESS (0.062s) [507.982556] Starting dynamic subtest: ccs0 [508.025113] Dynamic subtest ccs0: SUCCESS (0.052s) [508.027356] Subtest engines-cleanup: SUCCESS (0.301s) [508.123312] [121/156] (517s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [508.224079] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu [508.227632] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [508.333649] [122/156] (517s left) kms_psr (fbc-psr-cursor-blt) [508.426353] Starting subtest: fbc-psr-cursor-blt [508.428431] Starting dynamic subtest: eDP-1 [508.431998] Dynamic subtest eDP-1: SKIP (0.000s) [508.435518] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [508.503509] [123/156] (517s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [508.597307] Starting subtest: yf-tiled-addfb-size-offset-overflow [508.601178] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [508.718484] [124/156] (517s left) gem_exec_create (legacy) [508.787739] Starting subtest: legacy [508.789856] Starting dynamic subtest: smem [512.584386] Dynamic subtest smem: SUCCESS (3.701s) [512.587739] Subtest legacy: SUCCESS (3.703s) [512.777403] [125/156] (513s left) kms_cursor_crc (cursor-rapid-movement-128x42) [513.008751] Starting subtest: cursor-rapid-movement-128x42 [513.063563] Subtest cursor-rapid-movement-128x42: SKIP (0.049s) [513.305396] [126/156] (512s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [513.404069] Starting subtest: fbcpsr-tiling-4 [520.626744] Subtest fbcpsr-tiling-4: SUCCESS (7.146s) [520.743555] [127/156] (505s left) gem_mmap_offset (clear-via-pagefault) [520.806305] Starting subtest: clear-via-pagefault [520.808669] Starting dynamic subtest: smem0 [553.265515] Dynamic subtest smem0: SUCCESS (32.397s) [553.267717] Subtest clear-via-pagefault: SUCCESS (32.399s) [553.365969] [128/156] (472s left) kms_plane_multiple (2x-tiling-none) [553.472787] Starting subtest: 2x-tiling-none [553.477301] Subtest 2x-tiling-none: SKIP (0.000s) [553.547435] [129/156] (472s left) i915_hangman (engine-error-state-capture) [553.605340] Starting subtest: engine-error-state-capture [553.607582] Starting dynamic subtest: rcs0 [557.542343] Dynamic subtest rcs0: SUCCESS (3.933s) [557.558623] Starting dynamic subtest: bcs0 [563.557993] Dynamic subtest bcs0: SUCCESS (6.010s) [563.571737] Starting dynamic subtest: vcs0 [569.510597] Dynamic subtest vcs0: SUCCESS (5.947s) [569.524774] Starting dynamic subtest: vcs1 [574.500953] Dynamic subtest vcs1: SUCCESS (4.986s) [574.515236] Starting dynamic subtest: vecs0 [579.495050] Dynamic subtest vecs0: SUCCESS (4.988s) [579.510221] Starting dynamic subtest: ccs0 [584.549923] Dynamic subtest ccs0: SUCCESS (5.051s) [584.553018] Subtest engine-error-state-capture: SUCCESS (30.930s) [584.650527] [130/156] (441s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [584.766275] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [584.770439] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [584.873986] [131/156] (441s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [584.976309] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt [584.980686] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [585.092867] [132/156] (441s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [585.188419] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [585.192752] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [585.283896] [133/156] (440s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [585.386609] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [585.390761] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [585.477354] [134/156] (440s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [585.525575] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [585.588084] [135/156] (440s left) gem_exec_async (concurrent-writes) [585.649895] Starting subtest: concurrent-writes [585.651836] Starting dynamic subtest: rcs0 [585.667895] Dynamic subtest rcs0: SUCCESS (0.018s) [585.679069] Starting dynamic subtest: bcs0 [585.680795] Dynamic subtest bcs0: SUCCESS (0.005s) [585.692639] Starting dynamic subtest: vcs0 [585.694401] Dynamic subtest vcs0: SUCCESS (0.006s) [585.710677] Starting dynamic subtest: vcs1 [585.712420] Dynamic subtest vcs1: SUCCESS (0.007s) [585.722463] Starting dynamic subtest: vecs0 [585.724300] Dynamic subtest vecs0: SUCCESS (0.005s) [585.734179] Starting dynamic subtest: ccs0 [585.736033] Dynamic subtest ccs0: SUCCESS (0.005s) [585.737869] Subtest concurrent-writes: SUCCESS (0.052s) [585.944238] [136/156] (440s left) kms_pm_rpm (dpms-non-lpsp) [587.776075] Starting subtest: dpms-non-lpsp [587.781677] Subtest dpms-non-lpsp: SKIP (0.001s) [588.214178] [137/156] (438s left) gem_lmem_swapping (basic) [588.259373] Subtest basic: SKIP (0.000s) [588.305289] [138/156] (438s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [588.388728] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [588.393073] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [588.461863] [139/156] (438s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [588.553401] Starting subtest: fbcpsr-rgb101010-draw-pwrite [593.684293] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.135s) [593.818485] [140/156] (432s left) kms_feature_discovery (chamelium) [593.923999] Starting subtest: chamelium [593.928513] Subtest chamelium: SKIP (0.000s) [593.999130] [141/156] (432s left) kms_async_flips (test-cursor-atomic) [594.102490] Starting subtest: test-cursor-atomic [594.484596] Starting dynamic subtest: pipe-A-eDP-1 [595.271993] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s) [595.655414] Starting dynamic subtest: pipe-B-eDP-1 [596.405829] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s) [596.801953] Starting dynamic subtest: pipe-C-eDP-1 [597.556818] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s) [597.926900] Starting dynamic subtest: pipe-D-eDP-1 [598.683276] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s) [598.685722] Subtest test-cursor-atomic: SUCCESS (4.582s) [599.857139] [142/156] (426s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite) [599.968477] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite [599.972591] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [600.058180] [143/156] (426s left) gem_sync (basic-store-all) [600.132914] Starting subtest: basic-store-all [602.989611] Subtest basic-store-all: SUCCESS (2.867s) [603.177502] [144/156] (423s left) gem_pxp (create-regular-context-1) [603.301800] Starting subtest: create-regular-context-1 [603.304606] Subtest create-regular-context-1: SUCCESS (0.002s) [603.408166] [145/156] (423s left) kms_frontbuffer_tracking (fbc-stridechange) [603.510457] Starting subtest: fbc-stridechange [606.832548] Subtest fbc-stridechange: SUCCESS (3.329s) [608.048314] [146/156] (418s left) intel_hwmon (hwmon-write) [608.102193] Subtest hwmon-write: SKIP (0.000s) [608.167775] [147/156] (418s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [608.266839] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [608.270899] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [608.371173] [148/156] (418s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [608.423793] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [608.428751] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [608.611362] [149/156] (418s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [608.712184] Starting subtest: psr2-primary-plane-update-sf-dmg-area [608.714625] Starting dynamic subtest: pipe-A-eDP-1 [614.623756] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.920s) [614.636891] Starting dynamic subtest: pipe-B-eDP-1 [621.300773] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.674s) [621.302667] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.597s) [622.184579] [150/156] (404s left) gem_mmap_gtt (basic-write) [622.242426] Subtest basic-write: SKIP (0.000s) [622.312342] [151/156] (404s left) kms_plane (plane-position-hole) [622.407883] Starting subtest: plane-position-hole [622.942528] Starting dynamic subtest: pipe-A-plane-1 [624.287091] Dynamic subtest pipe-A-plane-1: SUCCESS (1.346s) [624.298640] Starting dynamic subtest: pipe-A-plane-2 [625.617406] Dynamic subtest pipe-A-plane-2: SUCCESS (1.329s) [625.633280] Starting dynamic subtest: pipe-A-plane-3 [626.943181] Dynamic subtest pipe-A-plane-3: SUCCESS (1.325s) [626.958450] Starting dynamic subtest: pipe-A-plane-4 [628.295123] Dynamic subtest pipe-A-plane-4: SUCCESS (1.352s) [628.307150] Starting dynamic subtest: pipe-A-plane-5 [628.322968] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s) [629.509993] Starting dynamic subtest: pipe-B-plane-1 [630.854454] Dynamic subtest pipe-B-plane-1: SUCCESS (1.352s) [630.866022] Starting dynamic subtest: pipe-B-plane-2 [632.159765] Dynamic subtest pipe-B-plane-2: SUCCESS (1.305s) [632.171395] Starting dynamic subtest: pipe-B-plane-3 [633.479319] Dynamic subtest pipe-B-plane-3: SUCCESS (1.319s) [633.491294] Starting dynamic subtest: pipe-B-plane-4 [634.816603] Dynamic subtest pipe-B-plane-4: SUCCESS (1.334s) [634.833769] Starting dynamic subtest: pipe-B-plane-5 [634.841949] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [634.844334] Subtest plane-position-hole: SUCCESS (12.434s) [635.696574] [152/156] (391s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [635.795056] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [635.799150] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [635.896461] [153/156] (391s left) gem_exec_params (rs-invalid) [635.952168] Starting subtest: rs-invalid [635.956861] Subtest rs-invalid: SUCCESS (0.003s) [636.066832] [154/156] (391s left) syncobj_timeline (host-signal-ordered) [636.118731] Starting subtest: host-signal-ordered [636.121040] Subtest host-signal-ordered: SUCCESS (0.000s) [636.239187] [155/156] (390s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [636.341895] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc [636.346148] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [636.456710] [156/156] (390s left) gem_exec_params (secure-non-master) [636.507307] Starting subtest: secure-non-master [636.511756] Subtest secure-non-master: SKIP (0.000s) [636.629142] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_big_fb results: parsing output: 2/ for test: kms_psr results: parsing output: 3/ for test: kms_chamelium_edid results: parsing output: 4/ for test: i915_drm_fdinfo results: parsing output: 5/ for test: kms_vrr results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: gem_close_race results: parsing output: 9/ for test: kms_flip results: parsing output: 10/ for test: kms_flip_scaled_crc results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: perf_pmu results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_mmap results: parsing output: 15/ for test: kms_rotation_crc results: parsing output: 16/ for test: kms_lease results: parsing output: 17/ for test: gem_busy results: parsing output: 18/ for test: kms_ccs results: parsing output: 19/ for test: kms_chamelium_hpd results: parsing output: 20/ for test: api_intel_bb results: parsing output: 21/ for test: gem_spin_batch results: parsing output: 22/ for test: kms_dp_link_training results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: syncobj_wait results: parsing output: 29/ for test: syncobj_basic results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_plane_scaling results: parsing output: 32/ for test: gem_mmap_gtt results: parsing output: 33/ for test: kms_cursor_crc results: parsing output: 34/ for test: syncobj_timeline results: parsing output: 35/ for test: i915_pm_rps results: parsing output: 36/ for test: kms_psr results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: vgem_basic results: parsing output: 39/ for test: core_setmaster results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: gem_fence_thrash results: parsing output: 42/ for test: gem_set_tiling_vs_gtt results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: template results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: prime_vgem results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_workarounds results: parsing output: 50/ for test: kms_flip_scaled_crc results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_big_fb results: parsing output: 55/ for test: gem_userptr_blits results: parsing output: 56/ for test: gem_exec_fence results: parsing output: 57/ for test: gem_sync results: parsing output: 58/ for test: gem_mmap results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_vblank results: parsing output: 62/ for test: gem_exec_schedule results: parsing output: 63/ for test: perf_pmu results: parsing output: 64/ for test: kms_cursor_crc results: parsing output: 65/ for test: kms_invalid_mode results: parsing output: 66/ for test: sw_sync results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: core_auth results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: perf_pmu results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_exec_suspend results: parsing output: 75/ for test: gem_exec_schedule results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_wait results: parsing output: 80/ for test: kms_prop_blob results: parsing output: 81/ for test: gem_exec_schedule results: parsing output: 82/ for test: gem_mmap_gtt results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_exec_params results: parsing output: 88/ for test: gem_exec_balancer results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: syncobj_timeline results: parsing output: 91/ for test: kms_pipe_crc_basic results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: vgem_basic results: parsing output: 94/ for test: gem_exec_reloc results: parsing output: 95/ for test: kms_color results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: gem_exec_schedule results: parsing output: 98/ for test: gem_ctx_exec results: parsing output: 99/ for test: kms_ccs results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_cursor_legacy results: parsing output: 104/ for test: gem_eio results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: sysfs_heartbeat_interval results: parsing output: 109/ for test: gen7_exec_parse results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: i915_suspend results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_addfb_basic results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_content_protection results: parsing output: 117/ for test: gem_ctx_persistence results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: gem_ctx_persistence results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_psr results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: gem_exec_create results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_mmap_offset results: parsing output: 127/ for test: kms_plane_multiple results: parsing output: 128/ for test: i915_hangman results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: kms_pipe_b_c_ivb results: parsing output: 134/ for test: gem_exec_async results: parsing output: 135/ for test: kms_pm_rpm results: parsing output: 136/ for test: gem_lmem_swapping results: parsing output: 137/ for test: kms_plane results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: kms_feature_discovery results: parsing output: 140/ for test: kms_async_flips results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: gem_sync results: parsing output: 143/ for test: gem_pxp results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: intel_hwmon results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: gem_render_copy results: parsing output: 148/ for test: kms_psr2_sf results: parsing output: 149/ for test: gem_mmap_gtt results: parsing output: 150/ for test: kms_plane results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: gem_exec_params results: parsing output: 153/ for test: syncobj_timeline results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: gem_exec_params Done.