[77.179954] Initializing watchdogs [77.180015] /dev/watchdog0 [77.194992] [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] [77.199750] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [77.202122] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [77.205511] [001/155] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [77.335688] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [84.066941] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.737s) [84.191106] [002/155] (953s left) kms_psr (fbc-psr2-cursor-plane-onoff) [84.276074] Starting subtest: fbc-psr2-cursor-plane-onoff [84.278408] Starting dynamic subtest: eDP-1 [84.282575] Dynamic subtest eDP-1: SKIP (0.000s) [84.286685] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s) [84.345162] [003/155] (953s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [84.447020] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [84.451605] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [84.536854] [004/155] (953s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt) [84.635898] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt [84.640055] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [84.748017] [005/155] (953s left) gem_mmap_offset (partial-unmap) [84.808366] Starting subtest: partial-unmap [84.810737] Starting dynamic subtest: smem0 [85.315629] Dynamic subtest smem0: SUCCESS (0.508s) [85.318197] Subtest partial-unmap: SUCCESS (0.508s) [85.437928] [006/155] (952s left) gem_exec_reloc (basic-gtt-read) [85.498158] Subtest basic-gtt-read: SKIP (0.000s) [85.564118] [007/155] (952s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [85.649093] Starting subtest: plane-scaler-unity-scaling-with-modifiers [85.651471] Starting dynamic subtest: pipe-A [85.985963] Dynamic subtest pipe-A: SUCCESS (0.339s) [85.994081] Starting dynamic subtest: pipe-B [87.427385] Dynamic subtest pipe-B: SUCCESS (1.441s) [87.437091] Starting dynamic subtest: pipe-C [88.869259] Dynamic subtest pipe-C: SUCCESS (1.441s) [88.883328] Starting dynamic subtest: pipe-D [90.286911] Dynamic subtest pipe-D: SUCCESS (1.417s) [90.289401] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.640s) [91.684934] [008/155] (946s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [91.788550] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [91.790946] Starting dynamic subtest: pipe-A-eDP-1 [91.814353] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [91.824213] Starting dynamic subtest: pipe-B-eDP-1 [91.846289] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [91.853603] Starting dynamic subtest: pipe-C-eDP-1 [91.876038] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [91.883488] Starting dynamic subtest: pipe-D-eDP-1 [91.908705] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [91.913615] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s) [94.049829] [009/155] (943s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [94.160653] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [101.488955] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.333s) [101.607678] [010/155] (936s left) gem_create (create-ext-cpu-access-big) [101.784705] Starting subtest: create-ext-cpu-access-big [101.789442] Subtest create-ext-cpu-access-big: SKIP (0.001s) [101.859071] [011/155] (936s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [101.904103] Starting subtest: invalid-multi-wait-unsubmitted [101.906564] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [101.991699] [012/155] (936s left) kms_frontbuffer_tracking (pipe-fbc-rte) [102.088849] Starting subtest: pipe-fbc-rte [102.095813] Starting dynamic subtest: pipe-B-eDP-1 [107.556021] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.473s) [107.564251] Subtest pipe-fbc-rte: SUCCESS (5.474s) [109.819099] [013/155] (928s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [109.917824] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [109.921979] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [110.000554] [014/155] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [110.097891] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [110.102433] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [110.199739] [015/155] (928s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [110.252789] Starting subtest: legacy-engines-hostile-preempt [110.254722] Starting dynamic subtest: render [110.325683] Dynamic subtest render: SUCCESS (0.075s) [110.337468] Starting dynamic subtest: bsd1 [112.300703] Dynamic subtest bsd1: SUCCESS (1.971s) [112.311899] Starting dynamic subtest: bsd2 [114.309162] Dynamic subtest bsd2: SUCCESS (2.006s) [114.319853] Starting dynamic subtest: blt [114.372549] Dynamic subtest blt: SUCCESS (0.062s) [114.383706] Starting dynamic subtest: vebox [116.283581] Dynamic subtest vebox: SUCCESS (1.907s) [116.286661] Subtest legacy-engines-hostile-preempt: SUCCESS (6.032s) [116.373423] [016/155] (921s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [116.479393] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [116.483505] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [116.569490] [017/155] (921s left) kms_async_flips (crc) [116.667034] Starting subtest: crc [117.044284] Starting dynamic subtest: pipe-A-eDP-1 [119.942525] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.898s) [120.326530] Starting dynamic subtest: pipe-B-eDP-1 [123.282359] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.964s) [123.656598] Starting dynamic subtest: pipe-C-eDP-1 [126.583630] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.937s) [126.947865] Starting dynamic subtest: pipe-D-eDP-1 [129.812117] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.872s) [129.814547] Subtest crc: SUCCESS (13.148s) [130.989114] [018/155] (907s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-plflip-blt) [131.099922] Starting subtest: hdr-1p-primscrn-shrfb-plflip-blt [131.104144] Subtest hdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [131.194398] [019/155] (907s left) kms_scaling_modes (scaling-mode-none) [131.291427] Starting subtest: scaling-mode-none [131.293938] Starting dynamic subtest: pipe-A-eDP-1 [131.389657] Dynamic subtest pipe-A-eDP-1: SKIP (0.098s) [131.399920] Starting dynamic subtest: pipe-B-eDP-1 [131.424979] Dynamic subtest pipe-B-eDP-1: SKIP (0.033s) [131.433283] Starting dynamic subtest: pipe-C-eDP-1 [131.459195] Dynamic subtest pipe-C-eDP-1: SKIP (0.033s) [131.468999] Starting dynamic subtest: pipe-D-eDP-1 [131.494113] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s) [131.498245] Subtest scaling-mode-none: SKIP (0.203s) [131.613299] [020/155] (906s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [131.709748] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-wc [131.714245] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [131.785021] [021/155] (906s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt) [131.876158] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt [131.880109] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [131.995010] [022/155] (906s left) syncobj_timeline (invalid-signal-illegal-point) [132.043754] Starting subtest: invalid-signal-illegal-point [132.045732] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [132.140911] [023/155] (906s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [132.241125] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [132.244723] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [132.333889] [024/155] (906s left) kms_mmap_write_crc (main) [132.430393] Starting subtest: main [132.431987] Starting dynamic subtest: pipe-A-eDP-1 [135.975359] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.544s) [135.977247] Subtest main: SUCCESS (3.545s) [136.818197] [025/155] (901s left) gem_pread (bench) [136.885617] Subtest bench: SKIP (0.000s) [136.942315] [026/155] (901s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [137.049062] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [137.053259] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s) [137.116044] [027/155] (901s left) kms_busy (basic-hang) [137.219204] Starting subtest: basic-hang [137.221462] Starting dynamic subtest: flip-pipe-A [137.800530] Dynamic subtest flip-pipe-A: SUCCESS (0.581s) [137.809357] Starting dynamic subtest: modeset-pipe-A [141.242059] Dynamic subtest modeset-pipe-A: SUCCESS (3.440s) [141.252679] Starting dynamic subtest: flip-pipe-D [142.479147] Dynamic subtest flip-pipe-D: SUCCESS (1.236s) [142.488593] Starting dynamic subtest: modeset-pipe-D [145.895581] Dynamic subtest modeset-pipe-D: SUCCESS (3.416s) [145.897825] Subtest basic-hang: SUCCESS (8.679s) [146.708128] [028/155] (892s left) kms_getfb (getfb-handle-not-fb) [146.812293] Starting subtest: getfb-handle-not-fb [146.814579] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [146.918935] [029/155] (891s left) kms_pm_rpm (drm-resources-equal) [148.449835] Starting subtest: drm-resources-equal [153.856245] Subtest drm-resources-equal: SUCCESS (5.410s) [153.944317] [030/155] (884s left) kms_big_fb (x-tiled-64bpp-rotate-0) [154.049465] Starting subtest: x-tiled-64bpp-rotate-0 [155.728287] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.679s) [155.868343] [031/155] (882s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render) [155.969038] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render [155.972683] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [156.067598] [032/155] (882s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [156.173115] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [156.176392] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [156.280838] [033/155] (882s left) vgem_basic (second-client) [156.367504] Starting subtest: second-client [156.392458] Subtest second-client: SUCCESS (0.022s) [156.445030] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true [156.448333] [034/155] (882s left) kms_cdclk (mode-transition-all-outputs) [156.539323] Starting subtest: mode-transition-all-outputs [156.830199] Subtest mode-transition-all-outputs: SKIP (0.286s) [157.726825] [035/155] (881s left) gem_exec_params (rs-invalid) [157.793846] Starting subtest: rs-invalid [157.798868] Subtest rs-invalid: SUCCESS (0.003s) [157.896812] [036/155] (881s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render) [157.998472] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render [158.002457] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [158.102948] [037/155] (880s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render) [158.201046] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render [158.205575] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [158.306168] [038/155] (880s left) gem_mmap (short-mmap) [158.356746] Subtest short-mmap: SKIP (0.000s) [158.418806] [039/155] (880s left) kms_big_fb (4-tiled-16bpp-rotate-270) [158.519290] Starting subtest: 4-tiled-16bpp-rotate-270 [158.538525] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s) [158.666874] [040/155] (880s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [158.762455] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [158.764452] Starting dynamic subtest: pipe-A-eDP-1 [158.783475] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [158.793061] Starting dynamic subtest: pipe-B-eDP-1 [158.810296] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [158.817796] Starting dynamic subtest: pipe-C-eDP-1 [158.835765] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [158.843316] Starting dynamic subtest: pipe-D-eDP-1 [158.861522] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [158.865234] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s) [161.083924] [041/155] (878s left) kms_flip (plain-flip-fb-recreate) [161.187796] Starting subtest: plain-flip-fb-recreate [161.189801] Starting dynamic subtest: A-eDP1 [170.077078] Dynamic subtest A-eDP1: SUCCESS (8.891s) [170.088079] Starting dynamic subtest: B-eDP1 [178.911853] Dynamic subtest B-eDP1: SUCCESS (8.833s) [178.922102] Starting dynamic subtest: C-eDP1 [187.740280] Dynamic subtest C-eDP1: SUCCESS (8.827s) [187.750675] Starting dynamic subtest: D-eDP1 [196.572830] Dynamic subtest D-eDP1: SUCCESS (8.831s) [196.576994] Subtest plain-flip-fb-recreate: SUCCESS (35.390s) [197.766769] [042/155] (841s left) kms_flip (2x-busy-flip) [197.865956] Starting subtest: 2x-busy-flip [197.875181] Subtest 2x-busy-flip: SKIP (0.011s) [197.989945] [043/155] (841s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [198.096581] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt [198.100646] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [198.198372] [044/155] (841s left) gem_render_copy (yf-tiled-to-vebox-x-tiled) [198.258378] Starting subtest: yf-tiled-to-vebox-x-tiled [198.262446] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s) [198.462907] [045/155] (840s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [198.555869] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [198.560469] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [198.667345] [046/155] (840s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [198.733450] Starting subtest: stress-mm-invalidate-close-overlap [200.880319] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [201.010168] [047/155] (838s left) i915_drm_fdinfo (context-close-stress) [201.053365] Starting subtest: context-close-stress [211.798827] Subtest context-close-stress: SUCCESS (10.744s) [211.874842] [048/155] (827s left) perf_pmu (most-busy-check-all) [211.913642] Starting subtest: most-busy-check-all [211.915976] Starting dynamic subtest: rcs0 [213.318583] Dynamic subtest rcs0: SUCCESS (1.404s) [213.332746] Starting dynamic subtest: bcs0 [215.303085] Dynamic subtest bcs0: SUCCESS (1.981s) [215.315360] Starting dynamic subtest: vcs0 [217.286484] Dynamic subtest vcs0: SUCCESS (1.980s) [217.300318] Starting dynamic subtest: vcs1 [219.271879] Dynamic subtest vcs1: SUCCESS (1.981s) [219.283623] Starting dynamic subtest: vecs0 [221.317811] Dynamic subtest vecs0: SUCCESS (2.044s) [221.327643] Starting dynamic subtest: ccs0 [223.301678] Dynamic subtest ccs0: SUCCESS (1.981s) [223.304606] Subtest most-busy-check-all: SUCCESS (11.388s) [223.415096] [049/155] (816s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [223.521842] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [223.526221] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [223.613752] [050/155] (816s left) perf (invalid-oa-metric-set-id) [223.741846] Starting subtest: invalid-oa-metric-set-id [223.754975] Subtest invalid-oa-metric-set-id: SUCCESS (0.013s) [223.797721] [051/155] (815s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [223.857497] Starting subtest: etime-multi-wait-all-available-unsubmitted [223.962200] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.103s) [224.037389] [052/155] (815s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-blt) [224.137654] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-blt [224.141778] Subtest fbchdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [224.243418] [053/155] (815s left) kms_big_fb (4-tiled-32bpp-rotate-180) [224.352499] Starting subtest: 4-tiled-32bpp-rotate-180 [225.696139] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.345s) [225.844253] [054/155] (813s left) kms_cursor_crc (cursor-sliding-32x32) [225.998674] Starting subtest: cursor-sliding-32x32 [226.049116] Subtest cursor-sliding-32x32: SKIP (0.044s) [226.333902] [055/155] (813s left) kms_cursor_legacy (forked-move) [226.446122] Starting subtest: forked-move [226.447987] Starting dynamic subtest: pipe-A [231.913723] Dynamic subtest pipe-A: SUCCESS (5.463s) [231.928405] Starting dynamic subtest: pipe-B [237.393620] Dynamic subtest pipe-B: SUCCESS (5.478s) [237.405248] Starting dynamic subtest: pipe-C [242.873071] Dynamic subtest pipe-C: SUCCESS (5.476s) [242.889838] Starting dynamic subtest: pipe-D [248.342980] Dynamic subtest pipe-D: SUCCESS (5.468s) [248.354280] Starting dynamic subtest: all-pipes [253.862852] Dynamic subtest all-pipes: SUCCESS (5.517s) [253.865494] Subtest forked-move: SUCCESS (27.413s) [254.010623] [056/155] (785s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [254.115550] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [254.119716] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s) [254.188576] [057/155] (785s left) kms_plane_scaling (planes-upscale-20x20) [254.294746] Starting subtest: planes-upscale-20x20 [254.297332] Starting dynamic subtest: pipe-A [254.353865] Dynamic subtest pipe-A: SUCCESS (0.062s) [254.364125] Starting dynamic subtest: pipe-B [255.488224] Dynamic subtest pipe-B: SUCCESS (1.133s) [255.499237] Starting dynamic subtest: pipe-C [256.597189] Dynamic subtest pipe-C: SUCCESS (1.108s) [256.606142] Starting dynamic subtest: pipe-D [257.749234] Dynamic subtest pipe-D: SUCCESS (1.151s) [257.751485] Subtest planes-upscale-20x20: SUCCESS (3.458s) [258.899071] [058/155] (781s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe) [259.278252] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s) [260.120482] [059/155] (779s left) api_intel_allocator (fork-simple-stress) [260.185224] Starting subtest: fork-simple-stress [265.581869] Subtest fork-simple-stress: SUCCESS (5.397s) [265.706031] [060/155] (774s left) kms_vblank (wait-idle-hang) [265.803581] Starting subtest: wait-idle-hang [265.805590] Starting dynamic subtest: pipe-A-eDP-1 [292.119353] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.315s) [292.135231] Starting dynamic subtest: pipe-D-eDP-1 [317.064974] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.939s) [317.066954] Subtest wait-idle-hang: SUCCESS (51.259s) [317.896945] [061/155] (722s left) kms_vblank (query-forked-busy-hang) [317.983360] Starting subtest: query-forked-busy-hang [317.985570] Starting dynamic subtest: pipe-A-eDP-1 [344.065091] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.080s) [344.078633] Starting dynamic subtest: pipe-D-eDP-1 [369.031726] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.965s) [369.033966] Subtest query-forked-busy-hang: SUCCESS (51.049s) [369.860949] [062/155] (670s left) kms_chamelium_frames (dp-crc-fast) [370.242920] Subtest dp-crc-fast: SKIP (0.000s) [371.070013] [063/155] (669s left) i915_query (query-topology-unsupported) [371.122973] Starting subtest: query-topology-unsupported [371.127074] Subtest query-topology-unsupported: SKIP (0.000s) [371.239220] [064/155] (669s left) syncobj_timeline (wait-for-submit-snapshot) [371.300618] Starting subtest: wait-for-submit-snapshot [371.383422] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [371.473311] [065/155] (668s left) kms_color_pipeline (plane-ctm3x4) [371.569368] Starting subtest: plane-ctm3x4 [371.749428] Starting dynamic subtest: pipe-A-plane-0 [371.894926] Dynamic subtest pipe-A-plane-0: SUCCESS (0.143s) [371.904618] Starting dynamic subtest: pipe-A-plane-1 [372.025817] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [372.035520] Starting dynamic subtest: pipe-A-plane-2 [372.137268] Dynamic subtest pipe-A-plane-2: SUCCESS (0.110s) [373.389138] Starting dynamic subtest: pipe-B-plane-0 [373.515703] Dynamic subtest pipe-B-plane-0: SUCCESS (0.133s) [373.528920] Starting dynamic subtest: pipe-B-plane-1 [373.626383] Dynamic subtest pipe-B-plane-1: SUCCESS (0.110s) [373.636022] Starting dynamic subtest: pipe-B-plane-2 [373.737583] Dynamic subtest pipe-B-plane-2: SUCCESS (0.110s) [374.926563] Starting dynamic subtest: pipe-C-plane-0 [375.026443] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s) [375.035857] Starting dynamic subtest: pipe-C-plane-1 [375.137665] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s) [375.150293] Starting dynamic subtest: pipe-C-plane-2 [375.271090] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s) [376.445927] Starting dynamic subtest: pipe-D-plane-0 [376.548912] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s) [376.558438] Starting dynamic subtest: pipe-D-plane-1 [376.660458] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s) [376.669868] Starting dynamic subtest: pipe-D-plane-2 [376.771394] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s) [377.076632] Subtest plane-ctm3x4: SUCCESS (5.508s) [377.922444] [066/155] (662s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [378.018812] Starting subtest: psr-1p-pri-indfb-multidraw [401.032804] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.019s) [401.144439] [067/155] (639s left) gem_exec_schedule (preempt-queue) [401.220511] Subtest preempt-queue: SKIP (0.000s) [401.525374] [068/155] (638s left) gem_softpin (noreloc-s3) [401.585435] Starting subtest: noreloc-S3 [421.835589] Subtest noreloc-S3: SUCCESS (5.394s) [421.967782] [069/155] (618s left) core_sysfs (read-all-entries) [422.038580] Starting subtest: read-all-entries [422.049149] Subtest read-all-entries: SUCCESS (0.012s) [422.126273] [070/155] (618s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt) [422.225865] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt [422.230011] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [422.333309] [071/155] (618s left) i915_pm_rc6_residency (rc6-idle) [422.389330] Starting subtest: rc6-idle [422.425651] Starting dynamic subtest: gt0-rcs0 [446.802360] Dynamic subtest gt0-rcs0: SUCCESS (24.367s) [446.814517] Starting dynamic subtest: gt0-bcs0 [471.159191] Dynamic subtest gt0-bcs0: SUCCESS (24.355s) [471.171536] Starting dynamic subtest: gt0-ccs0 [495.542837] Dynamic subtest gt0-ccs0: SUCCESS (24.379s) [495.552426] Starting dynamic subtest: gt1-vcs0 [501.716547] Dynamic subtest gt1-vcs0: SUCCESS (6.169s) [501.734085] Starting dynamic subtest: gt1-vecs0 [507.889617] Dynamic subtest gt1-vecs0: SUCCESS (6.169s) [507.892385] Subtest rc6-idle: SUCCESS (85.490s) [507.972203] [072/155] (532s left) gem_flink_basic (basic) [508.020372] Starting subtest: basic [508.022481] Subtest basic: SUCCESS (0.000s) [508.121697] [073/155] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [508.218657] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [514.902741] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.688s) [515.045241] [074/155] (525s left) gem_exec_endless (dispatch) [515.120321] Starting subtest: dispatch [515.122680] Starting dynamic subtest: rcs0 [515.127211] Dynamic subtest rcs0: SUCCESS (0.005s) [515.138094] Starting dynamic subtest: bcs0 [515.142740] Dynamic subtest bcs0: SUCCESS (0.004s) [515.153577] Starting dynamic subtest: vcs0 [515.158092] Dynamic subtest vcs0: SUCCESS (0.004s) [515.168683] Starting dynamic subtest: vcs1 [515.172637] Dynamic subtest vcs1: SUCCESS (0.005s) [515.182258] Starting dynamic subtest: vecs0 [515.186441] Dynamic subtest vecs0: SUCCESS (0.007s) [515.195664] Starting dynamic subtest: ccs0 [515.199735] Dynamic subtest ccs0: SUCCESS (0.006s) [515.201657] Subtest dispatch: SUCCESS (0.038s) [517.177612] [075/155] (523s left) i915_pm_freq_api (freq-reset) [517.241201] Starting subtest: freq-reset [517.243101] Starting dynamic subtest: gt0 [517.436227] Dynamic subtest gt0: SUCCESS (0.195s) [517.448656] Starting dynamic subtest: gt1 [517.607476] Dynamic subtest gt1: SUCCESS (0.172s) [517.610210] Subtest freq-reset: SUCCESS (0.369s) [517.685246] [076/155] (523s left) gem_userptr_blits (sd-probe) [517.752997] Starting subtest: sd-probe [517.755344] Subtest sd-probe: SUCCESS (0.000s) [517.898017] [077/155] (522s left) gem_exec_fence (syncobj-timeline-invalid-wait) [518.506871] Starting subtest: syncobj-timeline-invalid-wait [518.513712] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.007s) [520.225411] [078/155] (520s left) gem_render_copy (linear-to-vebox-y-tiled) [520.292445] Starting subtest: linear-to-vebox-y-tiled [520.296648] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [520.486961] [079/155] (520s left) syncobj_timeline (reset-during-wait-for-submit) [520.538845] Starting subtest: reset-during-wait-for-submit [520.643524] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [520.725387] [080/155] (520s left) kms_content_protection (dp-mst-type-0-hdcp14) [520.872933] Starting subtest: dp-mst-type-0-hdcp14 [520.877514] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [521.017553] [081/155] (519s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [521.118641] Starting subtest: fbcpsr-tiling-y [521.122831] Subtest fbcpsr-tiling-y: SKIP (0.000s) [521.220804] [082/155] (519s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [521.310686] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [521.322919] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [521.413561] [083/155] (519s left) kms_flip (flip-vs-suspend) [521.499274] Starting subtest: flip-vs-suspend [521.501684] Starting dynamic subtest: A-eDP1 [682.806043] Dynamic subtest A-eDP1: SUCCESS (12.216s) [682.808523] Subtest flip-vs-suspend: SUCCESS (12.218s) [682.943034] [084/155] (358s left) gem_lmem_swapping (verify-random-ccs) [682.994947] Subtest verify-random-ccs: SKIP (0.000s) [683.049830] [085/155] (358s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-blt) [683.160843] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-blt [683.165175] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [683.259372] [086/155] (357s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt) [683.356695] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt [683.361838] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [683.461841] [087/155] (357s left) kms_getfb (getfb-repeated-different-handles) [683.547139] Starting subtest: getfb-repeated-different-handles [683.549274] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [683.658524] [088/155] (357s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [683.763849] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [683.766295] Starting dynamic subtest: pipe-A-eDP-1 [689.682313] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.913s) [689.693506] Starting dynamic subtest: pipe-B-eDP-1 [696.367302] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.677s) [696.370189] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.593s) [697.235923] [089/155] (344s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [697.362242] Starting subtest: cursorA-vs-flipA-varying-size [708.491311] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.124s) [709.367863] [090/155] (332s left) gem_exec_whisper (basic-contexts-all) [709.430303] Starting subtest: basic-contexts-all [719.276143] Subtest basic-contexts-all: SUCCESS (9.841s) [719.457894] [091/155] (321s left) gem_eio (unwedge-stress) [719.718244] Starting subtest: unwedge-stress [719.720990] Starting dynamic subtest: render [724.872016] Dynamic subtest render: SUCCESS (5.152s) [724.888374] Starting dynamic subtest: bsd1 [760.279474] Dynamic subtest bsd1: SUCCESS (35.402s) [760.296354] Starting dynamic subtest: bsd2 [796.315228] Dynamic subtest bsd2: SUCCESS (36.031s) [796.331197] Starting dynamic subtest: blt [796.335901] Dynamic subtest blt: SKIP (0.000s) [796.346313] Starting dynamic subtest: vebox [832.285653] Dynamic subtest vebox: SUCCESS (35.971s) [832.287532] Subtest unwedge-stress: SUCCESS (112.560s) [834.262423] [092/155] (207s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [834.362181] Starting subtest: primary-yf-tiled-reflect-x-0 [834.424294] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.061s) [834.530695] [093/155] (206s left) gem_lmem_swapping (heavy-verify-random-ccs) [834.574123] Subtest heavy-verify-random-ccs: SKIP (0.000s) [834.619085] [094/155] (206s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [834.671507] Subtest no-spare-fences-interruptible: SKIP (0.000s) [834.748387] [095/155] (206s left) gem_exec_schedule (u-fairslice) [834.815549] Starting subtest: u-fairslice [834.817915] Starting dynamic subtest: rcs0 [836.831523] Dynamic subtest rcs0: SUCCESS (2.022s) [836.842063] Starting dynamic subtest: bcs0 [838.853308] Dynamic subtest bcs0: SUCCESS (2.022s) [838.864073] Starting dynamic subtest: vcs0 [840.878904] Dynamic subtest vcs0: SUCCESS (2.022s) [840.890258] Starting dynamic subtest: vcs1 [842.902992] Dynamic subtest vcs1: SUCCESS (2.025s) [842.916014] Starting dynamic subtest: vecs0 [844.926271] Dynamic subtest vecs0: SUCCESS (2.020s) [844.937284] Starting dynamic subtest: ccs0 [846.950971] Dynamic subtest ccs0: SUCCESS (2.024s) [846.953488] Subtest u-fairslice: SUCCESS (12.142s) [847.255646] [096/155] (194s left) syncobj_wait (invalid-signal-bad-pad) [847.313547] Starting subtest: invalid-signal-bad-pad [847.316343] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [847.423745] [097/155] (194s left) gem_ccs (block-multicopy-inplace) [847.483367] Starting subtest: block-multicopy-inplace [847.488658] Subtest block-multicopy-inplace: SKIP (0.000s) [847.606900] [098/155] (194s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [847.713851] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [847.718716] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [847.812557] [099/155] (193s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-msflip-blt) [847.909088] Starting subtest: fbchdr-2p-primscrn-indfb-msflip-blt [847.914235] Subtest fbchdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [848.001418] [100/155] (193s left) kms_properties (connector-properties-legacy) [848.099345] Starting subtest: connector-properties-legacy [848.102257] Starting dynamic subtest: pipe-A-eDP-1 [856.295209] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.195s) [856.306495] Starting dynamic subtest: pipe-None-DP-1 [856.311380] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [856.321527] Starting dynamic subtest: pipe-None-HDMI-A-1 [856.326955] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [856.337117] Starting dynamic subtest: pipe-None-DP-2 [856.342070] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [856.355150] Starting dynamic subtest: pipe-None-HDMI-A-2 [856.359979] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [856.370542] Starting dynamic subtest: pipe-None-DP-3 [856.375965] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [856.386520] Starting dynamic subtest: pipe-None-DP-4 [856.391999] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [856.394406] Subtest connector-properties-legacy: SUCCESS (8.207s) [857.157374] [101/155] (184s left) kms_psr (psr-no-drrs) [857.261044] Starting subtest: psr-no-drrs [857.263477] Starting dynamic subtest: eDP-1 [858.943950] Dynamic subtest eDP-1: SUCCESS (1.680s) [858.946391] Subtest psr-no-drrs: SUCCESS (1.681s) [859.841857] [102/155] (182s left) gem_exec_reloc (basic-wc-gtt) [859.933613] Subtest basic-wc-gtt: SKIP (0.000s) [860.020698] [103/155] (181s left) api_intel_bb (reset-bb) [860.101714] Starting subtest: reset-bb [860.104142] Subtest reset-bb: SUCCESS (0.004s) [860.343873] [104/155] (181s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [860.458426] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [860.464419] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [860.539369] [105/155] (181s left) perf_pmu (interrupts-sync) [860.590313] Starting subtest: interrupts-sync [861.673339] Subtest interrupts-sync: SUCCESS (1.080s) [861.796816] [106/155] (180s left) kms_addfb_basic (addfb25-modifier-no-flag) [861.898521] Starting subtest: addfb25-modifier-no-flag [861.900999] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [861.996037] [107/155] (180s left) kms_prop_blob (invalid-set-prop-any) [862.054041] Starting subtest: invalid-set-prop-any [862.056765] Subtest invalid-set-prop-any: SUCCESS (0.000s) [862.165777] [108/155] (180s left) gem_ctx_isolation (nonpriv-switch) [862.232315] Starting subtest: nonpriv-switch [862.234607] Starting dynamic subtest: rcs0 [862.519079] Dynamic subtest rcs0: SUCCESS (0.289s) [862.531331] Starting dynamic subtest: bcs0 [862.833661] Dynamic subtest bcs0: SUCCESS (0.314s) [862.847341] Starting dynamic subtest: vcs0 [863.133339] Dynamic subtest vcs0: SUCCESS (0.298s) [863.145371] Starting dynamic subtest: vcs1 [864.512115] Dynamic subtest vcs1: SUCCESS (1.377s) [864.524878] Starting dynamic subtest: vecs0 [866.530172] Dynamic subtest vecs0: SUCCESS (2.017s) [866.540912] Starting dynamic subtest: ccs0 [868.623885] Dynamic subtest ccs0: SUCCESS (2.091s) [868.626918] Subtest nonpriv-switch: SUCCESS (6.393s) [868.856688] [109/155] (173s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs) [868.954148] Starting subtest: random-ccs-data-4-tiled-bmg-ccs [868.959171] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s) [870.060804] [110/155] (172s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite) [870.159787] Starting subtest: fbc-rgb101010-draw-pwrite [873.501900] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.348s) [874.679141] [111/155] (167s left) sriov_basic (bind-unbind-vf) [874.739070] Starting subtest: bind-unbind-vf [874.742168] Starting dynamic subtest: vf-1 [874.830213] Dynamic subtest vf-1: FAIL (0.016s) [874.842477] Starting dynamic subtest: vf-2 [874.929620] Dynamic subtest vf-2: FAIL (0.004s) [874.940933] Starting dynamic subtest: vf-3 [875.027290] Dynamic subtest vf-3: FAIL (0.004s) [875.038499] Starting dynamic subtest: vf-4 [875.125230] Dynamic subtest vf-4: FAIL (0.004s) [875.137061] Starting dynamic subtest: vf-5 [875.222905] Dynamic subtest vf-5: FAIL (0.004s) [875.233866] Starting dynamic subtest: vf-6 [875.320905] Dynamic subtest vf-6: FAIL (0.004s) [875.333315] Starting dynamic subtest: vf-7 [875.418361] Dynamic subtest vf-7: FAIL (0.004s) [875.428289] Starting dynamic subtest: vf-random [875.503522] Dynamic subtest vf-random: FAIL (0.004s) [875.513621] Starting dynamic subtest: vf-last [875.593231] Dynamic subtest vf-last: FAIL (0.605s) [875.595483] Subtest bind-unbind-vf: FAIL (0.654s) [875.647564] [112/155] (166s left) gem_exec_balancer (noheartbeat) [875.913492] Starting subtest: noheartbeat [875.919435] Subtest noheartbeat: SKIP (0.000s) [876.017127] [113/155] (166s left) gem_mmap_gtt (basic-copy) [876.073828] Subtest basic-copy: SKIP (0.000s) [876.139911] [114/155] (166s left) gem_eio (create) [876.349188] Starting subtest: create [876.680567] Subtest create: SUCCESS (0.330s) [876.795818] [115/155] (165s left) gen7_exec_parse (chained-batch) [876.852766] Subtest chained-batch: SKIP (0.000s) [876.919164] [116/155] (165s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [877.010382] Starting subtest: crc-primary-suspend-yf-tiled-ccs [877.012636] Starting dynamic subtest: pipe-A-eDP-1 [877.020807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [877.031694] Starting dynamic subtest: pipe-B-eDP-1 [877.039546] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [877.050251] Starting dynamic subtest: pipe-C-eDP-1 [877.059310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [877.069606] Starting dynamic subtest: pipe-D-eDP-1 [877.078280] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [877.082305] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s) [879.346989] [117/155] (163s left) gem_softpin (reverse) [879.404658] Starting subtest: reverse [879.411237] Subtest reverse: SUCCESS (0.006s) [879.554630] [118/155] (163s left) vgem_basic (unload) [879.595647] Starting subtest: unload [908.633533] Subtest unload: SUCCESS (29.034s) [908.736176] [119/155] (133s left) kms_psr (fbc-psr-no-drrs) [908.841080] Starting subtest: fbc-psr-no-drrs [908.843438] Starting dynamic subtest: eDP-1 [908.848338] Dynamic subtest eDP-1: SKIP (0.000s) [908.853131] Subtest fbc-psr-no-drrs: SKIP (0.001s) [908.916640] [120/155] (133s left) kms_lease (cursor-implicit-plane) [909.004360] Starting subtest: cursor-implicit-plane [909.007120] Starting dynamic subtest: pipe-A-eDP-1 [909.464790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s) [909.476378] Starting dynamic subtest: pipe-B-eDP-1 [910.567684] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.098s) [910.580098] Starting dynamic subtest: pipe-C-eDP-1 [911.688514] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s) [911.702257] Starting dynamic subtest: pipe-D-eDP-1 [912.818272] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s) [912.821052] Subtest cursor-implicit-plane: SUCCESS (3.816s) [913.675257] [121/155] (129s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite) [913.779042] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite [913.784314] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [913.872743] [122/155] (128s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move) [913.966770] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move [913.971940] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [914.061936] [123/155] (128s left) gem_readwrite (new-obj) [914.116212] Subtest new-obj: SKIP (0.000s) [914.178946] [124/155] (128s left) kms_psr (pr-cursor-plane-onoff) [914.261758] Starting subtest: pr-cursor-plane-onoff [914.267037] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [914.333870] [125/155] (128s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [914.442309] Starting subtest: psr-2p-primscrn-spr-indfb-move [914.447319] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [914.534863] [126/155] (128s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt) [914.631014] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt [914.635520] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [914.716064] [127/155] (128s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt) [914.815302] Starting subtest: hdr-rgb565-draw-blt [914.819291] Subtest hdr-rgb565-draw-blt: SKIP (0.000s) [914.913822] [128/155] (128s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [914.996061] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [915.000631] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [915.068015] [129/155] (128s left) kms_pm_rpm (pm-caching) [916.588909] Starting subtest: pm-caching [916.594516] Subtest pm-caching: SKIP (0.000s) [917.313866] [130/155] (125s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [917.416759] Starting subtest: yf-tiled-64bpp-rotate-90 [917.421896] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [917.522817] [131/155] (125s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite) [917.620338] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite [917.625349] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [917.722714] [132/155] (125s left) perf (gen12-unprivileged-single-ctx-counters) [917.809510] Starting subtest: gen12-unprivileged-single-ctx-counters [917.812278] Starting dynamic subtest: rcs0 [917.846897] Dynamic subtest rcs0: SUCCESS (0.037s) [917.849425] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.038s) [917.892481] [133/155] (125s left) kms_cursor_crc (cursor-rapid-movement-32x10) [918.078146] Starting subtest: cursor-rapid-movement-32x10 [918.123930] Subtest cursor-rapid-movement-32x10: SKIP (0.040s) [918.406329] [134/155] (124s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [918.495863] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [918.507074] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s) [918.585007] [135/155] (124s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [918.678166] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [919.569484] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.892s) [919.723769] [136/155] (123s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [919.848942] Starting subtest: cursorA-vs-flipA-legacy [930.987501] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.138s) [931.834380] [137/155] (111s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt) [931.940323] Starting subtest: fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt [931.945272] Subtest fbcpsrhdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [932.053605] [138/155] (111s left) kms_draw_crc (draw-method-mmap-cpu) [932.140648] Starting subtest: draw-method-mmap-cpu [932.142938] Starting dynamic subtest: xrgb8888-untiled [932.405833] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s) [932.419133] Starting dynamic subtest: rgb565-untiled [932.627999] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [932.639102] Starting dynamic subtest: xrgb2101010-untiled [932.850247] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [932.863078] Starting dynamic subtest: xbgr16161616f-untiled [933.072100] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [933.087135] Starting dynamic subtest: xrgb8888-xtiled [933.204996] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s) [933.215932] Starting dynamic subtest: rgb565-xtiled [933.328232] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s) [933.340114] Starting dynamic subtest: xrgb2101010-xtiled [933.461327] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s) [933.472118] Starting dynamic subtest: xbgr16161616f-xtiled [933.583060] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.120s) [933.593322] Starting dynamic subtest: xrgb8888-4tiled [933.727940] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.143s) [933.740238] Starting dynamic subtest: rgb565-4tiled [933.871900] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [933.882506] Starting dynamic subtest: xrgb2101010-4tiled [934.016815] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s) [934.029511] Starting dynamic subtest: xbgr16161616f-4tiled [934.161193] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [934.163266] Subtest draw-method-mmap-cpu: SUCCESS (2.024s) [934.257898] [139/155] (109s left) kms_big_fb (linear-8bpp-rotate-90) [934.365296] Starting subtest: linear-8bpp-rotate-90 [934.389755] Subtest linear-8bpp-rotate-90: SKIP (0.021s) [934.491220] [140/155] (109s left) kms_cursor_crc (cursor-offscreen-256x256) [934.753232] Starting subtest: cursor-offscreen-256x256 [934.755827] Starting dynamic subtest: pipe-A-eDP-1 [936.693544] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s) [936.727618] Starting dynamic subtest: pipe-D-eDP-1 [939.387136] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.671s) [939.389820] Subtest cursor-offscreen-256x256: SUCCESS (4.637s) [940.215611] [141/155] (103s left) i915_pm_rps (waitboost) [940.273185] Starting subtest: waitboost [946.362425] Subtest waitboost: SUCCESS (6.089s) [946.484765] [142/155] ( 97s left) gem_exec_parallel (fds) [946.550507] Starting subtest: fds [946.553209] Starting dynamic subtest: rcs0 [951.911173] Dynamic subtest rcs0: SUCCESS (5.358s) [951.922359] Starting dynamic subtest: bcs0 [957.073665] Dynamic subtest bcs0: SUCCESS (5.161s) [957.087170] Starting dynamic subtest: vcs0 [963.268520] Dynamic subtest vcs0: SUCCESS (6.192s) [963.281492] Starting dynamic subtest: vcs1 [968.301518] Dynamic subtest vcs1: SUCCESS (5.033s) [968.315806] Starting dynamic subtest: vecs0 [974.257168] Dynamic subtest vecs0: SUCCESS (5.952s) [974.272029] Starting dynamic subtest: ccs0 [979.590834] Dynamic subtest ccs0: SUCCESS (5.331s) [979.594010] Subtest fds: SUCCESS (33.038s) [979.806434] [143/155] ( 63s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [979.914309] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [979.919374] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [980.016795] [144/155] ( 63s left) kms_plane_lowres (tiling-none) [980.108335] Starting subtest: tiling-none [980.111271] Starting dynamic subtest: pipe-A-eDP-1 [980.117032] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [980.407854] Starting dynamic subtest: pipe-B-eDP-1 [980.414227] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [980.428500] Starting dynamic subtest: pipe-C-eDP-1 [980.433948] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [980.444737] Starting dynamic subtest: pipe-D-eDP-1 [980.450299] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [980.455546] Subtest tiling-none: SKIP (0.296s) [981.236650] [145/155] ( 62s left) kms_psr (fbc-pr-cursor-plane-onoff) [981.328490] Starting subtest: fbc-pr-cursor-plane-onoff [981.333335] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [981.401563] [146/155] ( 62s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [981.506576] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [981.511734] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [981.607250] [147/155] ( 62s left) gem_userptr_blits (process-exit-busy) [981.664985] Starting subtest: process-exit-busy [981.678482] Subtest process-exit-busy: SUCCESS (0.016s) [981.792963] [148/155] ( 62s left) kms_hdr (invalid-metadata-sizes) [981.889359] Starting subtest: invalid-metadata-sizes [981.892156] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [981.897266] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s) [981.909538] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [981.914482] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s) [981.920021] Subtest invalid-metadata-sizes: SKIP (0.002s) [981.965418] [149/155] ( 62s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [982.064217] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [988.926995] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.867s) [989.052678] [150/155] ( 55s left) kms_addfb_basic (invalid-get-prop) [989.107657] Starting subtest: invalid-get-prop [989.110404] Subtest invalid-get-prop: SUCCESS (0.000s) [989.241386] [151/155] ( 54s left) sysfs_heartbeat_interval (mixed) [989.300133] Starting subtest: mixed [989.302673] Starting dynamic subtest: vecs0 [994.496272] Dynamic subtest vecs0: SUCCESS (5.196s) [994.509727] Starting dynamic subtest: ccs0 [999.745156] Dynamic subtest ccs0: SUCCESS (5.246s) [999.758081] Starting dynamic subtest: vcs0 [1004.940962] Dynamic subtest vcs0: SUCCESS (5.193s) [1004.954398] Starting dynamic subtest: bcs0 [1010.144498] Dynamic subtest bcs0: SUCCESS (5.201s) [1010.158092] Starting dynamic subtest: rcs0 [1015.367289] Dynamic subtest rcs0: SUCCESS (5.221s) [1015.380156] Starting dynamic subtest: vcs1 [1020.552211] Dynamic subtest vcs1: SUCCESS (5.182s) [1020.555490] Subtest mixed: SUCCESS (31.250s) [1020.632721] [152/155] ( 23s left) kms_atomic_interruptible (legacy-pageflip) [1020.724405] Starting subtest: legacy-pageflip [1020.727283] Starting dynamic subtest: pipe-A-eDP-1 [1028.202074] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.476s) [1028.204759] Subtest legacy-pageflip: SUCCESS (7.477s) [1029.030256] [153/155] ( 15s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [1029.131959] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [1029.136416] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [1029.225157] [154/155] ( 15s left) syncobj_basic (bad-pad-handle-to-fd) [1029.284242] Starting subtest: bad-pad-handle-to-fd [1029.286325] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [1029.383145] [155/155] ( 14s left) kms_plane_multiple (tiling-y) [1029.475620] Starting subtest: tiling-y [1029.480503] Subtest tiling-y: SKIP (0.000s) [1029.560399] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_mmap_offset results: parsing output: 5/ for test: gem_exec_reloc results: parsing output: 6/ for test: kms_plane_scaling results: parsing output: 7/ for test: kms_ccs results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_create results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_ctx_persistence results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_async_flips results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_scaling_modes results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: syncobj_timeline results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_mmap_write_crc results: parsing output: 24/ for test: gem_pread results: parsing output: 25/ for test: kms_flip_scaled_crc results: parsing output: 26/ for test: kms_busy results: parsing output: 27/ for test: kms_getfb results: parsing output: 28/ for test: kms_pm_rpm results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: vgem_basic results: parsing output: 33/ for test: kms_cdclk results: parsing output: 34/ for test: gem_exec_params results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_mmap results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: kms_ccs results: parsing output: 40/ for test: kms_flip results: parsing output: 41/ for test: kms_flip results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_render_copy results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: gem_userptr_blits results: parsing output: 46/ for test: i915_drm_fdinfo results: parsing output: 47/ for test: perf_pmu results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: perf results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_cursor_legacy results: parsing output: 55/ for test: kms_flip_scaled_crc results: parsing output: 56/ for test: kms_plane_scaling results: parsing output: 57/ for test: kms_chamelium_hpd results: parsing output: 58/ for test: api_intel_allocator results: parsing output: 59/ for test: kms_vblank results: parsing output: 60/ for test: kms_vblank results: parsing output: 61/ for test: kms_chamelium_frames results: parsing output: 62/ for test: i915_query results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: kms_color_pipeline results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_exec_schedule results: parsing output: 67/ for test: gem_softpin results: parsing output: 68/ for test: core_sysfs results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: i915_pm_rc6_residency results: parsing output: 71/ for test: gem_flink_basic results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: gem_exec_endless results: parsing output: 74/ for test: i915_pm_freq_api results: parsing output: 75/ for test: gem_userptr_blits results: parsing output: 76/ for test: gem_exec_fence results: parsing output: 77/ for test: gem_render_copy results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: kms_content_protection results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: kms_flip results: parsing output: 83/ for test: gem_lmem_swapping 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_getfb results: parsing output: 87/ for test: kms_psr2_sf results: parsing output: 88/ for test: kms_cursor_legacy results: parsing output: 89/ for test: gem_exec_whisper results: parsing output: 90/ for test: gem_eio results: parsing output: 91/ for test: kms_rotation_crc results: parsing output: 92/ for test: gem_lmem_swapping results: parsing output: 93/ for test: gem_fenced_exec_thrash results: parsing output: 94/ for test: gem_exec_schedule results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: gem_ccs results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_properties results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: gem_exec_reloc results: parsing output: 102/ for test: api_intel_bb results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: perf_pmu results: parsing output: 105/ for test: kms_addfb_basic results: parsing output: 106/ for test: kms_prop_blob results: parsing output: 107/ for test: gem_ctx_isolation results: parsing output: 108/ for test: kms_ccs results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: sriov_basic results: parsing output: 111/ for test: gem_exec_balancer results: parsing output: 112/ for test: gem_mmap_gtt results: parsing output: 113/ for test: gem_eio results: parsing output: 114/ for test: gen7_exec_parse results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: gem_softpin results: parsing output: 117/ for test: vgem_basic results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_lease results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_readwrite results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_plane results: parsing output: 128/ for test: kms_pm_rpm results: parsing output: 129/ for test: kms_big_fb results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: perf results: parsing output: 132/ for test: kms_cursor_crc results: parsing output: 133/ for test: kms_flip results: parsing output: 134/ for test: kms_big_fb results: parsing output: 135/ for test: kms_cursor_legacy results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_draw_crc results: parsing output: 138/ for test: kms_big_fb results: parsing output: 139/ for test: kms_cursor_crc results: parsing output: 140/ for test: i915_pm_rps results: parsing output: 141/ for test: gem_exec_parallel results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_plane_lowres results: parsing output: 144/ for test: kms_psr results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: gem_userptr_blits results: parsing output: 147/ for test: kms_hdr results: parsing output: 148/ for test: kms_frontbuffer_tracking results: parsing output: 149/ for test: kms_addfb_basic results: parsing output: 150/ for test: sysfs_heartbeat_interval results: parsing output: 151/ for test: kms_atomic_interruptible results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: syncobj_basic results: parsing output: 154/ for test: kms_plane_multiple Done.