[56.223546] Initializing watchdogs [56.223594] /dev/watchdog0 [56.238873] [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] [56.243349] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.245610] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.248888] [001/156] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [56.366929] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [56.369363] Starting dynamic subtest: pipe-A-eDP-1 [56.426547] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [56.434237] Starting dynamic subtest: pipe-B-eDP-1 [56.487464] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [56.495469] Starting dynamic subtest: pipe-C-eDP-1 [56.550466] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [56.558893] Starting dynamic subtest: pipe-D-eDP-1 [56.616451] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [56.621087] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s) [58.655436] [002/156] (958s left) kms_psr (pr-primary-mmap-gtt) [58.757393] Starting subtest: pr-primary-mmap-gtt [58.761584] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [58.839367] [003/156] (957s left) api_intel_bb (intel-bb-blit-none) [58.885265] Starting subtest: intel-bb-blit-none [62.726343] Subtest intel-bb-blit-none: SUCCESS (3.869s) [62.829589] [004/156] (954s left) vgem_basic (dmabuf-export) [62.892965] Starting subtest: dmabuf-export [62.927437] Subtest dmabuf-export: SUCCESS (0.036s) [63.026059] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true [63.029138] [005/156] (953s left) gem_create (create-size-update) [63.081154] Starting subtest: create-size-update [63.083076] Subtest create-size-update: SUCCESS (0.000s) [63.287606] [006/156] (953s left) gen7_exec_parse (chained-batch) [63.344351] Subtest chained-batch: SKIP (0.000s) [63.412070] [007/156] (953s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [63.528410] Starting subtest: x-tiled-addfb-size-offset-overflow [63.530816] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [63.637621] [008/156] (953s left) gem_mmap_gtt (basic-copy) [63.687698] Subtest basic-copy: SKIP (0.000s) [63.741594] [009/156] (953s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [63.841162] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [63.844983] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [63.951223] [010/156] (953s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc) [64.064194] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc [64.068219] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [64.159960] [011/156] (952s left) gem_exec_balancer (sliced) [64.216632] Starting subtest: sliced [64.220311] Subtest sliced: SKIP (0.000s) [64.521608] [012/156] (952s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [64.621868] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [64.626517] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [64.705505] [013/156] (952s left) kms_psr (fbc-psr-cursor-plane-onoff) [64.814168] Starting subtest: fbc-psr-cursor-plane-onoff [64.816059] Starting dynamic subtest: eDP-1 [64.820131] Dynamic subtest eDP-1: SKIP (0.000s) [64.824192] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [64.887150] [014/156] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite) [64.985183] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite [64.989213] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [65.074017] [015/156] (952s left) gem_exec_await (wide-contexts) [65.258531] Starting subtest: wide-contexts [88.201084] Subtest wide-contexts: SUCCESS (22.966s) [88.396414] [016/156] (928s left) gem_ctx_persistence (smoketest) [88.500623] Starting subtest: smoketest [128.255544] Subtest smoketest: SUCCESS (39.750s) [128.359619] [017/156] (889s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [128.474665] Starting subtest: extended-pageflip-modeset-hang-oldfb [128.476704] Starting dynamic subtest: pipe-A [136.401871] Dynamic subtest pipe-A: SUCCESS (7.924s) [136.411509] Starting dynamic subtest: pipe-D [144.986622] Dynamic subtest pipe-D: SUCCESS (8.584s) [144.988966] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.512s) [145.839365] [018/156] (871s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [145.928442] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [145.930715] Starting dynamic subtest: pipe-A-eDP-1 [145.955743] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [145.967425] Starting dynamic subtest: pipe-B-eDP-1 [145.991170] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [145.999762] Starting dynamic subtest: pipe-C-eDP-1 [146.023362] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [146.031698] Starting dynamic subtest: pipe-D-eDP-1 [146.055432] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [146.059814] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [148.124313] [019/156] (869s left) gem_ctx_isolation (dirty-switch) [148.187080] Starting subtest: dirty-switch [148.189347] Starting dynamic subtest: rcs0 [148.394856] Dynamic subtest rcs0: SUCCESS (0.208s) [148.404304] Starting dynamic subtest: bcs0 [148.609760] Dynamic subtest bcs0: SUCCESS (0.214s) [148.620039] Starting dynamic subtest: vcs0 [148.843901] Dynamic subtest vcs0: SUCCESS (0.235s) [148.855405] Starting dynamic subtest: vcs1 [150.476089] Dynamic subtest vcs1: SUCCESS (1.631s) [150.486823] Starting dynamic subtest: vecs0 [152.557070] Dynamic subtest vecs0: SUCCESS (2.080s) [152.568065] Starting dynamic subtest: ccs0 [154.548487] Dynamic subtest ccs0: SUCCESS (1.991s) [154.550872] Subtest dirty-switch: SUCCESS (6.361s) [154.802592] [020/156] (862s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [154.903134] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [154.907163] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [154.981215] [021/156] (862s left) kms_plane_multiple (tiling-y) [155.078856] Starting subtest: tiling-y [155.083351] Subtest tiling-y: SKIP (0.000s) [155.161130] [022/156] (862s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [155.269606] Starting subtest: psr-rgb565-draw-mmap-gtt [155.274035] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [155.387238] [023/156] (862s left) kms_pm_rpm (dpms-non-lpsp) [157.515644] Starting subtest: dpms-non-lpsp [157.520483] Subtest dpms-non-lpsp: SKIP (0.001s) [157.906048] [024/156] (859s left) kms_psr (fbc-pr-cursor-plane-move) [158.003180] Starting subtest: fbc-pr-cursor-plane-move [158.007390] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [158.074910] [025/156] (859s left) kms_cursor_edge_walk (256x256-right-edge) [158.164467] Starting subtest: 256x256-right-edge [158.166585] Starting dynamic subtest: pipe-A-eDP-1 [161.646191] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.480s) [161.655482] Starting dynamic subtest: pipe-D-eDP-1 [164.766965] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s) [164.769222] Subtest 256x256-right-edge: SUCCESS (6.604s) [165.584107] [026/156] (852s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render) [165.690847] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render [165.695354] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [165.784013] [027/156] (852s left) i915_query (query-topology-matches-eu-total) [165.837610] Starting subtest: query-topology-matches-eu-total [165.839726] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [165.943091] [028/156] (851s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [166.034914] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [166.037345] Starting dynamic subtest: pipe-A [166.099235] Dynamic subtest pipe-A: SUCCESS (0.066s) [166.111672] Starting dynamic subtest: pipe-B [167.221695] Dynamic subtest pipe-B: SUCCESS (1.122s) [167.232136] Starting dynamic subtest: pipe-C [168.329305] Dynamic subtest pipe-C: SUCCESS (1.107s) [168.341111] Starting dynamic subtest: pipe-D [169.456471] Dynamic subtest pipe-D: SUCCESS (1.127s) [169.458876] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.423s) [170.610188] [029/156] (847s left) kms_cursor_legacy (torture-bo) [170.741104] Starting subtest: torture-bo [170.743512] Starting dynamic subtest: pipe-A [176.400748] Dynamic subtest pipe-A: SUCCESS (5.656s) [176.411017] Starting dynamic subtest: pipe-B [182.415634] Dynamic subtest pipe-B: SUCCESS (6.014s) [182.428462] Starting dynamic subtest: pipe-C [188.898653] Dynamic subtest pipe-C: SUCCESS (6.482s) [188.910411] Starting dynamic subtest: pipe-D [196.338716] Dynamic subtest pipe-D: SUCCESS (7.438s) [196.356035] Starting dynamic subtest: all-pipes [203.791791] Dynamic subtest all-pipes: SUCCESS (7.451s) [203.794574] Subtest torture-bo: SUCCESS (33.045s) [203.950538] [030/156] (813s left) kms_flip (2x-flip-vs-fences-interruptible) [204.041335] Starting subtest: 2x-flip-vs-fences-interruptible [204.045903] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [204.160684] [031/156] (813s left) kms_psr (fbc-psr2-sprite-plane-onoff) [204.243838] Starting subtest: fbc-psr2-sprite-plane-onoff [204.245788] Starting dynamic subtest: eDP-1 [204.249931] Dynamic subtest eDP-1: SKIP (0.000s) [204.254107] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s) [204.317316] [032/156] (813s left) gem_sync (basic-each) [204.395970] Starting subtest: basic-each [206.545685] Subtest basic-each: SUCCESS (2.161s) [206.731923] [033/156] (811s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [206.836849] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [207.849403] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.013s) [208.004233] [034/156] (810s left) kms_rotation_crc (bad-pixel-format) [208.109388] Starting subtest: bad-pixel-format [208.112871] Subtest bad-pixel-format: SKIP (0.001s) [208.180410] [035/156] (809s left) perf_pmu (init-busy) [208.217584] Starting subtest: init-busy [208.219469] Starting dynamic subtest: rcs0 [208.221225] Dynamic subtest rcs0: SUCCESS (0.001s) [208.231408] Starting dynamic subtest: bcs0 [208.233223] Dynamic subtest bcs0: SUCCESS (0.001s) [208.241998] Starting dynamic subtest: vcs0 [208.244042] Dynamic subtest vcs0: SUCCESS (0.001s) [208.252620] Starting dynamic subtest: vcs1 [208.254562] Dynamic subtest vcs1: SUCCESS (0.001s) [208.263178] Starting dynamic subtest: vecs0 [208.265082] Dynamic subtest vecs0: SUCCESS (0.001s) [208.273504] Starting dynamic subtest: ccs0 [208.275091] Dynamic subtest ccs0: SUCCESS (0.001s) [208.276611] Subtest init-busy: SUCCESS (0.006s) [208.330839] [036/156] (809s left) kms_async_flips (crc) [208.418872] Starting subtest: crc [208.790977] Starting dynamic subtest: pipe-A-eDP-1 [211.735891] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.943s) [212.115322] Starting dynamic subtest: pipe-B-eDP-1 [215.062638] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.958s) [215.451927] Starting dynamic subtest: pipe-C-eDP-1 [218.382643] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.941s) [218.757464] Starting dynamic subtest: pipe-D-eDP-1 [221.615902] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.869s) [221.618218] Subtest crc: SUCCESS (13.198s) [222.776783] [037/156] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [222.873770] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [222.878174] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [222.970915] [038/156] (795s left) kms_lease (empty-lease) [223.063748] Starting subtest: empty-lease [223.065982] Starting dynamic subtest: pipe-A-eDP-1 [223.068277] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [223.078095] Starting dynamic subtest: pipe-B-eDP-1 [223.079913] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [223.088871] Starting dynamic subtest: pipe-C-eDP-1 [223.090719] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [223.099413] Starting dynamic subtest: pipe-D-eDP-1 [223.101260] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [223.103106] Subtest empty-lease: SUCCESS (0.007s) [223.192253] [039/156] (795s left) gem_exec_fence (submit67) [223.367613] Starting subtest: submit67 [223.371998] Subtest submit67: SKIP (0.000s) [225.398879] [040/156] (792s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-blt) [225.505643] Starting subtest: hdr-rgb101010-draw-blt [225.510183] Subtest hdr-rgb101010-draw-blt: SKIP (0.000s) [225.615286] [041/156] (792s left) prime_mmap (test_errors) [225.684052] Starting subtest: test_errors [225.686498] Starting dynamic subtest: test_errors-smem [225.786040] Dynamic subtest test_errors-smem: SUCCESS (0.101s) [225.788831] Subtest test_errors: SUCCESS (0.102s) [225.920419] [042/156] (792s left) gem_exec_create (madvise) [225.977660] Starting subtest: madvise [225.980131] Starting dynamic subtest: smem [246.136555] Dynamic subtest smem: SUCCESS (20.157s) [246.138928] Subtest madvise: SUCCESS (20.157s) [246.907354] [043/156] (771s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [246.964404] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [247.069814] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s) [247.146634] [044/156] (771s left) gem_exec_schedule (reorder-wide) [247.322317] Subtest reorder-wide: SKIP (0.000s) [247.502367] [045/156] (771s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [247.599718] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [247.604230] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [247.692876] [046/156] (770s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [247.787122] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [253.152537] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.372s) [254.303288] [047/156] (764s left) kms_chamelium_color (degamma) [254.396071] Subtest degamma: SKIP (0.000s) [254.444678] [048/156] (764s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling) [254.546090] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling [254.550178] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s) [254.620055] [049/156] (764s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [254.672662] Starting subtest: single-wait-all-for-submit-available-signaled [254.674935] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [254.770291] [050/156] (764s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [254.864591] Starting subtest: psr-1p-primscrn-spr-indfb-move [262.368250] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.509s) [262.507456] [051/156] (756s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [262.600031] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [262.602365] Starting dynamic subtest: pipe-A-eDP-1 [262.625468] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [262.636879] Starting dynamic subtest: pipe-B-eDP-1 [262.658558] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [262.667608] Starting dynamic subtest: pipe-C-eDP-1 [262.689874] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [262.700122] Starting dynamic subtest: pipe-D-eDP-1 [262.722283] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [262.726658] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [264.895267] [052/156] (753s left) gem_pxp (create-regular-context-2) [265.025888] Starting subtest: create-regular-context-2 [265.028743] Subtest create-regular-context-2: SUCCESS (0.002s) [265.136725] [053/156] (753s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [265.238498] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [265.242969] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [265.328062] [054/156] (753s left) syncobj_wait (multi-wait-for-submit-signaled) [265.380043] Starting subtest: multi-wait-for-submit-signaled [265.382414] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [265.492266] [055/156] (753s left) fbdev (info) [265.531716] Starting subtest: info [265.534050] Subtest info: SUCCESS (0.000s) [265.622431] [056/156] (753s left) gem_exec_reloc (basic-gtt-cpu-active) [265.690673] Subtest basic-gtt-cpu-active: SKIP (0.000s) [265.761524] [057/156] (753s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [265.851579] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [265.853504] Starting dynamic subtest: pipe-A-default-mode [266.971614] Dynamic subtest pipe-A-default-mode: SKIP (1.116s) [266.975545] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.117s) [267.110679] [058/156] (752s left) sw_sync (alloc_merge_fence) [267.145348] Starting subtest: alloc_merge_fence [267.147308] Subtest alloc_merge_fence: SUCCESS (0.000s) [267.204486] [059/156] (751s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [267.303821] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [274.269264] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.972s) [274.414284] [060/156] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [274.514042] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt [274.518259] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [274.616830] [061/156] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [274.715609] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [274.720067] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [274.813362] [062/156] (744s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt) [274.905435] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt [274.909698] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [275.012297] [063/156] (744s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [275.104578] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [275.108609] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [275.181982] [064/156] (744s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [275.231048] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [275.232896] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [275.331042] [065/156] (744s left) kms_flip (flip-vs-blocking-wf-vblank) [275.421280] Starting subtest: flip-vs-blocking-wf-vblank [275.423246] Starting dynamic subtest: A-eDP1 [284.338625] Dynamic subtest A-eDP1: SUCCESS (8.916s) [284.348464] Starting dynamic subtest: B-eDP1 [293.274994] Dynamic subtest B-eDP1: SUCCESS (8.934s) [293.287152] Starting dynamic subtest: C-eDP1 [302.194601] Dynamic subtest C-eDP1: SUCCESS (8.916s) [302.206851] Starting dynamic subtest: D-eDP1 [311.132740] Dynamic subtest D-eDP1: SUCCESS (8.935s) [311.135519] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.711s) [312.363748] [066/156] (707s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-msflip-blt) [312.470838] Starting subtest: psrhdr-2p-primscrn-indfb-msflip-blt [312.474701] Subtest psrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [312.573123] [067/156] (706s left) kms_lease (page-flip-implicit-plane) [312.668810] Starting subtest: page-flip-implicit-plane [312.671153] Starting dynamic subtest: pipe-A-eDP-1 [313.149944] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s) [313.162785] Starting dynamic subtest: pipe-B-eDP-1 [314.321058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s) [314.331862] Starting dynamic subtest: pipe-C-eDP-1 [315.425202] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s) [315.436023] Starting dynamic subtest: pipe-D-eDP-1 [316.553021] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s) [316.555266] Subtest page-flip-implicit-plane: SUCCESS (3.885s) [317.395637] [068/156] (702s left) gem_lmem_swapping (parallel-random-verify-ccs) [317.443213] Subtest parallel-random-verify-ccs: SKIP (0.000s) [317.483802] [069/156] (702s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [317.866290] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [318.707987] [070/156] (700s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff) [318.805160] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff [318.809424] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [318.913255] [071/156] (700s left) i915_drm_fdinfo (isolation) [318.953504] Starting subtest: isolation [318.955629] Starting dynamic subtest: rcs0 [318.972713] Dynamic subtest rcs0: SKIP (0.017s) [318.981896] Starting dynamic subtest: bcs0 [318.986447] Dynamic subtest bcs0: SKIP (0.012s) [318.995821] Starting dynamic subtest: vcs0 [319.000455] Dynamic subtest vcs0: SKIP (0.000s) [319.009620] Starting dynamic subtest: vcs1 [319.013774] Dynamic subtest vcs1: SKIP (0.000s) [319.023242] Starting dynamic subtest: vecs0 [319.027583] Dynamic subtest vecs0: SKIP (0.000s) [319.036706] Starting dynamic subtest: ccs0 [319.041083] Dynamic subtest ccs0: SKIP (0.000s) [319.045401] Subtest isolation: SKIP (0.034s) [319.084468] [072/156] (700s left) kms_rmfb (rmfb-ioctl) [319.175586] Starting subtest: rmfb-ioctl [319.177685] Starting dynamic subtest: pipe-A-eDP-1 [319.279691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [319.289925] Starting dynamic subtest: pipe-B-eDP-1 [320.492986] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.212s) [320.504595] Starting dynamic subtest: pipe-C-eDP-1 [321.614197] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s) [321.623793] Starting dynamic subtest: pipe-D-eDP-1 [322.748985] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [322.751360] Subtest rmfb-ioctl: SUCCESS (3.575s) [323.980361] [073/156] (695s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-plflip-blt) [324.090087] Starting subtest: hdr-2p-primscrn-indfb-plflip-blt [324.094254] Subtest hdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [324.177383] [074/156] (695s left) kms_addfb_basic (no-handle) [324.228903] Starting subtest: no-handle [324.231116] Subtest no-handle: SUCCESS (0.000s) [324.385604] [075/156] (695s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [324.483803] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [333.268418] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.790s) [333.380328] [076/156] (686s left) kms_pm_rpm (system-suspend-idle) [335.506351] Starting subtest: system-suspend-idle [355.156802] Subtest system-suspend-idle: SUCCESS (4.846s) [358.559609] [077/156] (664s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-pwrite) [358.668229] Starting subtest: fbchdr-rgb101010-draw-pwrite [358.672196] Subtest fbchdr-rgb101010-draw-pwrite: SKIP (0.000s) [358.778645] [078/156] (664s left) gem_ctx_shared (exec-single-timeline) [358.847147] Starting subtest: exec-single-timeline [358.849501] Starting dynamic subtest: rcs0 [359.893702] Dynamic subtest rcs0: SUCCESS (1.065s) [359.907404] Starting dynamic subtest: bcs0 [360.981775] Dynamic subtest bcs0: SUCCESS (1.106s) [360.995782] Starting dynamic subtest: vcs0 [362.068816] Dynamic subtest vcs0: SUCCESS (1.104s) [362.082331] Starting dynamic subtest: vcs1 [363.158557] Dynamic subtest vcs1: SUCCESS (1.103s) [363.171841] Starting dynamic subtest: vecs0 [364.246979] Dynamic subtest vecs0: SUCCESS (1.100s) [364.261061] Starting dynamic subtest: ccs0 [365.333843] Dynamic subtest ccs0: SUCCESS (1.096s) [365.336540] Subtest exec-single-timeline: SUCCESS (6.592s) [366.198520] [079/156] (656s left) api_intel_allocator (reloc-allocator) [366.249525] Starting subtest: reloc-allocator [366.251403] Starting dynamic subtest: basic [366.256028] Dynamic subtest basic: SUCCESS (0.007s) [366.266221] Starting dynamic subtest: parallel-one [366.269321] Dynamic subtest parallel-one: SUCCESS (0.007s) [366.279441] Starting dynamic subtest: print [366.281703] Dynamic subtest print: SUCCESS (0.000s) [366.292913] Starting dynamic subtest: reuse [366.294709] Dynamic subtest reuse: SUCCESS (0.000s) [366.304221] Starting dynamic subtest: fork-reopen-allocator [366.306102] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [366.307993] Subtest reloc-allocator: SUCCESS (0.032s) [366.406275] [080/156] (656s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [366.560974] Starting subtest: dp-mst-lic-type-0-hdcp14 [366.565228] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [366.683971] [081/156] (656s left) kms_cursor_crc (cursor-random-512x512) [366.970828] Starting subtest: cursor-random-512x512 [366.975509] Subtest cursor-random-512x512: SKIP (0.001s) [367.120594] [082/156] (656s left) kms_psr_stress_test (invalidate-primary-flip-overlay) [367.217469] Starting subtest: invalidate-primary-flip-overlay [377.937589] Subtest invalidate-primary-flip-overlay: SUCCESS (10.773s) [378.056101] [083/156] (645s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [378.161546] Starting subtest: fbcpsr-rgb101010-draw-blt [382.934049] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.784s) [383.056715] [084/156] (640s left) syncobj_basic (create-signaled) [383.100711] Starting subtest: create-signaled [383.102910] Subtest create-signaled: SUCCESS (0.000s) [383.195777] [085/156] (640s left) syncobj_wait (wait-any-complex) [383.237106] Starting subtest: wait-any-complex [383.297045] Subtest wait-any-complex: SUCCESS (0.062s) [383.374400] [086/156] (639s left) kms_color (gamma) [383.476631] Starting subtest: gamma [383.478448] Starting dynamic subtest: pipe-A-eDP-1 [384.204020] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s) [384.216733] Starting dynamic subtest: pipe-B-eDP-1 [385.596816] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.394s) [385.608448] Starting dynamic subtest: pipe-C-eDP-1 [386.982360] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s) [386.992574] Starting dynamic subtest: pipe-D-eDP-1 [388.312795] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s) [388.314669] Subtest gamma: SUCCESS (4.842s) [389.121435] [087/156] (634s left) gem_render_copy (yf-tiled-to-vebox-linear) [389.192011] Starting subtest: yf-tiled-to-vebox-linear [389.196639] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [389.378313] [088/156] (634s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [389.467678] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt [389.471967] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [389.555184] [089/156] (633s left) sysfs_preempt_timeout (invalid) [389.620210] Starting subtest: invalid [389.622612] Starting dynamic subtest: vecs0 [389.625240] Dynamic subtest vecs0: SUCCESS (0.000s) [389.635462] Starting dynamic subtest: ccs0 [389.637373] Dynamic subtest ccs0: SUCCESS (0.000s) [389.647607] Starting dynamic subtest: vcs0 [389.649927] Dynamic subtest vcs0: SUCCESS (0.000s) [389.660677] Starting dynamic subtest: bcs0 [389.662603] Dynamic subtest bcs0: SUCCESS (0.000s) [389.672037] Starting dynamic subtest: rcs0 [389.673901] Dynamic subtest rcs0: SUCCESS (0.000s) [389.683340] Starting dynamic subtest: vcs1 [389.685253] Dynamic subtest vcs1: SUCCESS (0.000s) [389.687127] Subtest invalid: SUCCESS (0.005s) [389.726619] [090/156] (633s left) gem_spin_batch (spin-all-new) [389.790356] Starting subtest: spin-all-new [389.802399] Subtest spin-all-new: SUCCESS (0.014s) [391.202967] [091/156] (632s left) kms_plane (plane-position-hole-dpms) [391.304510] Starting subtest: plane-position-hole-dpms [391.840194] Starting dynamic subtest: pipe-A-plane-1 [394.235626] Dynamic subtest pipe-A-plane-1: SUCCESS (2.397s) [394.248234] Starting dynamic subtest: pipe-A-plane-2 [396.598757] Dynamic subtest pipe-A-plane-2: SUCCESS (2.360s) [396.610063] Starting dynamic subtest: pipe-A-plane-3 [398.950757] Dynamic subtest pipe-A-plane-3: SUCCESS (2.352s) [398.961290] Starting dynamic subtest: pipe-A-plane-4 [401.322809] Dynamic subtest pipe-A-plane-4: SUCCESS (2.371s) [401.333034] Starting dynamic subtest: pipe-A-plane-5 [401.348596] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s) [402.481922] Starting dynamic subtest: pipe-B-plane-1 [404.936178] Dynamic subtest pipe-B-plane-1: SUCCESS (2.465s) [404.946703] Starting dynamic subtest: pipe-B-plane-2 [407.392847] Dynamic subtest pipe-B-plane-2: SUCCESS (2.458s) [407.404624] Starting dynamic subtest: pipe-B-plane-3 [409.838693] Dynamic subtest pipe-B-plane-3: SUCCESS (2.445s) [409.850432] Starting dynamic subtest: pipe-B-plane-4 [412.196394] Dynamic subtest pipe-B-plane-4: SUCCESS (2.358s) [412.208561] Starting dynamic subtest: pipe-B-plane-5 [412.223314] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [412.225629] Subtest plane-position-hole-dpms: SUCCESS (20.921s) [413.028997] [092/156] (610s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [413.136567] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [413.141023] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [413.236951] [093/156] (610s left) gem_exec_params (rsvd2-dirt) [413.301102] Starting subtest: rsvd2-dirt [413.305495] Subtest rsvd2-dirt: SKIP (0.000s) [413.413269] [094/156] (610s left) kms_explicit_fence (multiplane-atomic-fence-wait) [413.548528] Starting subtest: multiplane-atomic-fence-wait [413.868757] Subtest multiplane-atomic-fence-wait: SUCCESS (0.318s) [415.055825] [095/156] (608s left) kms_getfb (getfb2-handle-not-fb) [415.148461] Starting subtest: getfb2-handle-not-fb [415.150693] Subtest getfb2-handle-not-fb: SUCCESS (0.000s) [415.246049] [096/156] (608s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt) [415.340373] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt [415.344349] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [415.459461] [097/156] (608s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render) [415.555109] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render [415.559197] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [415.654479] [098/156] (608s left) gem_mmap_wc (invalid-flags) [415.723572] Subtest invalid-flags: SKIP (0.000s) [415.797809] [099/156] (608s left) gem_eio (wait-10ms) [416.026833] Starting subtest: wait-10ms [416.392938] Subtest wait-10ms: SUCCESS (0.367s) [416.559857] [100/156] (607s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-blt) [416.656427] Starting subtest: fbcpsrhdr-rgb101010-draw-blt [416.659995] Subtest fbcpsrhdr-rgb101010-draw-blt: SKIP (0.000s) [416.743184] [101/156] (607s left) prime_mmap (test_invalid_sync_flags) [416.795470] Starting subtest: test_invalid_sync_flags [416.797409] Starting dynamic subtest: test_invalid_sync_flags-smem [416.799200] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [416.800985] Subtest test_invalid_sync_flags: SUCCESS (0.001s) [416.882730] [102/156] (607s left) kms_flip (flip-vs-panning-vs-hang) [416.972378] Starting subtest: flip-vs-panning-vs-hang [416.974412] Starting dynamic subtest: A-eDP1 [421.016334] Dynamic subtest A-eDP1: SUCCESS (4.046s) [421.028096] Starting dynamic subtest: D-eDP1 [424.963732] Dynamic subtest D-eDP1: SUCCESS (3.948s) [424.966202] Subtest flip-vs-panning-vs-hang: SUCCESS (7.998s) [426.154018] [103/156] (597s left) syncobj_wait (invalid-reset-zero-handles) [426.214501] Starting subtest: invalid-reset-zero-handles [426.216974] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [426.323961] [104/156] (597s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [426.380497] Starting subtest: stress-mm-invalidate-close-overlap [428.527254] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [428.671592] [105/156] (595s left) gem_workarounds (suspend-resume) [428.732786] Starting subtest: suspend-resume [444.945728] Subtest suspend-resume: SUCCESS (1.584s) [453.097676] [106/156] (579s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [453.210025] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [453.984603] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.794s) [454.146442] [107/156] (578s left) kms_psr (psr-cursor-mmap-cpu) [454.243996] Starting subtest: psr-cursor-mmap-cpu [454.246275] Starting dynamic subtest: eDP-1 [455.929088] Dynamic subtest eDP-1: SUCCESS (1.715s) [455.931216] Subtest psr-cursor-mmap-cpu: SUCCESS (1.716s) [456.784213] [108/156] (575s left) gem_exec_whisper (basic-fds-priority-all) [456.841703] Starting subtest: basic-fds-priority-all [479.027754] Subtest basic-fds-priority-all: SUCCESS (22.296s) [479.211979] [109/156] (553s left) gen7_exec_parse (basic-offset) [479.272821] Subtest basic-offset: SKIP (0.000s) [479.345991] [110/156] (553s left) intel_hwmon (hwmon-read) [479.400349] Subtest hwmon-read: SKIP (0.000s) [479.463787] [111/156] (552s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt) [479.576782] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt [479.581201] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [479.673091] [112/156] (552s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [479.773991] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf [479.776280] Starting dynamic subtest: pipe-A-eDP-1 [479.849727] Dynamic subtest pipe-A-eDP-1: SKIP (0.079s) [479.865941] Starting dynamic subtest: pipe-B-eDP-1 [480.942550] Dynamic subtest pipe-B-eDP-1: SKIP (1.093s) [480.947155] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.174s) [482.141045] [113/156] (550s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [482.238553] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite [482.242912] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [482.325033] [114/156] (550s left) gem_render_copy (linear-to-vebox-y-tiled) [482.381396] Starting subtest: linear-to-vebox-y-tiled [482.385575] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [482.565427] [115/156] (550s left) gem_userptr_blits (unsync-unmap) [482.622921] Subtest unsync-unmap: SKIP (0.000s) [482.741403] [116/156] (549s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [482.825071] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [482.827358] Starting dynamic subtest: pipe-A-eDP-1 [500.183408] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s) [500.196554] Starting dynamic subtest: pipe-B-eDP-1 [518.142041] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.822s) [518.154803] Starting dynamic subtest: pipe-C-eDP-1 [536.109899] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.826s) [536.122654] Starting dynamic subtest: pipe-D-eDP-1 [554.111508] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.742s) [554.113980] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.209s) [564.362662] [117/156] (477s left) template (a) [564.415990] Starting subtest: A [564.418201] Subtest A: SUCCESS (0.000s) [564.523082] [118/156] (477s left) gem_exec_flush (basic-wb-pro-default) [564.578412] Starting subtest: basic-wb-pro-default [569.968368] Subtest basic-wb-pro-default: SUCCESS (5.475s) [570.159950] [119/156] (471s left) kms_async_flips (test-time-stamp-atomic) [570.253010] Starting subtest: test-time-stamp-atomic [570.634730] Starting dynamic subtest: pipe-A-eDP-1 [571.444272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.816s) [571.820320] Starting dynamic subtest: pipe-B-eDP-1 [572.572324] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s) [572.945040] Starting dynamic subtest: pipe-C-eDP-1 [573.701493] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s) [574.078228] Starting dynamic subtest: pipe-D-eDP-1 [574.837930] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s) [574.840610] Subtest test-time-stamp-atomic: SUCCESS (4.625s) [575.988985] [120/156] (465s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping) [576.081102] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping [576.107257] Starting dynamic subtest: pipe-A-plane-0 [576.373120] Dynamic subtest pipe-A-plane-0: SUCCESS (0.266s) [576.386904] Starting dynamic subtest: pipe-A-plane-3 [576.582952] Dynamic subtest pipe-A-plane-3: SUCCESS (0.210s) [577.671587] Starting dynamic subtest: pipe-B-plane-0 [577.959747] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s) [577.973908] Starting dynamic subtest: pipe-B-plane-3 [578.181199] Dynamic subtest pipe-B-plane-3: SUCCESS (0.222s) [578.500737] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.432s) [579.348127] [121/156] (462s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [579.463576] Starting subtest: yf-tiled-8bpp-rotate-90 [579.467873] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [579.569468] [122/156] (462s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [579.663743] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [579.666103] Starting dynamic subtest: pipe-A-default-mode [582.392050] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s) [582.394687] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.737s) [583.226249] [123/156] (458s left) i915_pm_rpm (gem-execbuf) [584.952390] Starting subtest: gem-execbuf [584.955361] Starting dynamic subtest: smem0 [586.499763] Dynamic subtest smem0: SUCCESS (1.550s) [586.501933] Subtest gem-execbuf: SUCCESS (1.552s) [586.597916] [124/156] (455s left) kms_vblank (ts-continuation-modeset-hang) [586.690828] Starting subtest: ts-continuation-modeset-hang [586.692907] Starting dynamic subtest: pipe-A-eDP-1 [613.617241] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.935s) [613.635899] Starting dynamic subtest: pipe-D-eDP-1 [637.616788] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.007s) [637.619044] Subtest ts-continuation-modeset-hang: SUCCESS (50.947s) [638.480163] [125/156] (403s left) sriov_basic (bind-unbind-vf) [638.535671] Starting subtest: bind-unbind-vf [638.538065] Starting dynamic subtest: vf-1 [638.618950] Dynamic subtest vf-1: FAIL (0.030s) [638.631978] Starting dynamic subtest: vf-2 [638.704986] Dynamic subtest vf-2: FAIL (0.004s) [638.717842] Starting dynamic subtest: vf-3 [638.790466] Dynamic subtest vf-3: FAIL (0.005s) [638.802579] Starting dynamic subtest: vf-4 [638.875391] Dynamic subtest vf-4: FAIL (0.004s) [638.887937] Starting dynamic subtest: vf-5 [638.958993] Dynamic subtest vf-5: FAIL (0.003s) [638.971474] Starting dynamic subtest: vf-6 [639.044571] Dynamic subtest vf-6: FAIL (0.004s) [639.057118] Starting dynamic subtest: vf-7 [639.129775] Dynamic subtest vf-7: FAIL (0.004s) [639.141052] Starting dynamic subtest: vf-random [639.213985] Dynamic subtest vf-random: FAIL (0.004s) [639.226733] Starting dynamic subtest: vf-last [639.299222] Dynamic subtest vf-last: FAIL (0.523s) [639.301566] Subtest bind-unbind-vf: FAIL (0.588s) [639.347321] [126/156] (402s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [639.435210] Starting subtest: bad-rotation-90-yf-tiled-ccs [639.436947] Starting dynamic subtest: pipe-A-eDP-1 [639.455335] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [639.467986] Starting dynamic subtest: pipe-B-eDP-1 [639.486300] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [639.498286] Starting dynamic subtest: pipe-C-eDP-1 [639.515999] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [639.526413] Starting dynamic subtest: pipe-D-eDP-1 [639.544710] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [639.548296] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s) [641.729251] [127/156] (400s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [641.791651] Starting subtest: invalid-single-wait-all-unsubmitted [641.793635] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [641.901747] [128/156] (400s left) vgem_basic (mmap) [641.949094] Starting subtest: mmap [641.990977] Subtest mmap: SUCCESS (0.044s) [642.054186] [129/156] (400s left) gem_ctx_exec (basic) [642.117391] Starting subtest: basic [642.123095] Subtest basic: SUCCESS (0.007s) [642.262734] [130/156] (400s left) gem_exec_reloc (basic-concurrent0) [642.318570] Subtest basic-concurrent0: SKIP (0.000s) [642.407610] [131/156] (399s left) perf (rc6-disable) [642.540630] Starting subtest: rc6-disable [642.716748] Subtest rc6-disable: SUCCESS (0.176s) [642.762237] [132/156] (399s left) kms_big_fb (4-tiled-32bpp-rotate-0) [642.854290] Starting subtest: 4-tiled-32bpp-rotate-0 [644.321980] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.468s) [644.470432] [133/156] (397s left) kms_cursor_crc (cursor-offscreen-256x256) [644.732355] Starting subtest: cursor-offscreen-256x256 [644.736486] Starting dynamic subtest: pipe-A-eDP-1 [646.681359] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.946s) [646.715181] Starting dynamic subtest: pipe-D-eDP-1 [649.328353] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s) [649.330638] Subtest cursor-offscreen-256x256: SUCCESS (4.596s) [650.193767] [134/156] (392s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf) [650.287480] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf [650.289821] Starting dynamic subtest: pipe-A-eDP-1 [661.276418] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.995s) [661.289484] Starting dynamic subtest: pipe-B-eDP-1 [673.006476] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.721s) [673.008614] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.720s) [673.861659] [135/156] (368s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [673.968794] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [673.972934] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [674.069184] [136/156] (368s left) i915_pm_freq_api (freq-basic-api) [674.127914] Starting subtest: freq-basic-api [674.130294] Starting dynamic subtest: gt0 [674.132596] Dynamic subtest gt0: SUCCESS (0.003s) [674.145466] Starting dynamic subtest: gt1 [674.147705] Dynamic subtest gt1: SUCCESS (0.003s) [674.149941] Subtest freq-basic-api: SUCCESS (0.008s) [674.249627] [137/156] (368s left) gem_exec_whisper (basic-queues-forked) [674.315239] Starting subtest: basic-queues-forked [698.885450] Subtest basic-queues-forked: SUCCESS (24.565s) [699.078465] [138/156] (343s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-render) [699.190646] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-render [699.194769] Subtest fbchdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [699.293858] [139/156] (343s left) gem_exec_schedule (implicit-write-read) [699.366114] Starting subtest: implicit-write-read [699.368337] Starting dynamic subtest: rcs0 [699.482434] Dynamic subtest rcs0: SUCCESS (0.125s) [699.495303] Starting dynamic subtest: vcs0 [699.566596] Dynamic subtest vcs0: SUCCESS (0.083s) [699.582115] Starting dynamic subtest: vcs1 [699.643709] Dynamic subtest vcs1: SUCCESS (0.076s) [699.658436] Starting dynamic subtest: vecs0 [699.726749] Dynamic subtest vecs0: SUCCESS (0.082s) [699.740247] Starting dynamic subtest: ccs0 [699.816634] Dynamic subtest ccs0: SUCCESS (0.089s) [699.818998] Subtest implicit-write-read: SUCCESS (0.461s) [700.954996] [140/156] (341s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [701.012492] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [701.112896] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s) [701.195172] [141/156] (341s left) core_setmaster (master-drop-set-root) [701.255291] Starting subtest: master-drop-set-root [701.274295] Subtest master-drop-set-root: SUCCESS (0.023s) [701.327634] [142/156] (341s left) kms_vblank (query-forked-hang) [701.433925] Starting subtest: query-forked-hang [701.435777] Starting dynamic subtest: pipe-A-eDP-1 [727.621460] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.188s) [727.638366] Starting dynamic subtest: pipe-D-eDP-1 [752.634590] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.019s) [752.636940] Subtest query-forked-hang: SUCCESS (51.212s) [753.517983] [143/156] (289s left) kms_big_fb (y-tiled-16bpp-rotate-180) [753.622651] Starting subtest: y-tiled-16bpp-rotate-180 [753.627078] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [753.733479] [144/156] (289s left) gem_mmap_offset (close-race) [753.782946] Starting subtest: close-race [773.903236] Subtest close-race: SUCCESS (20.126s) [774.021263] [145/156] (268s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-move) [774.125256] Starting subtest: psrhdr-2p-primscrn-spr-indfb-move [774.129484] Subtest psrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [774.224582] [146/156] (268s left) perf_pmu (busy-idle-check-all) [774.262504] Starting subtest: busy-idle-check-all [774.264343] Starting dynamic subtest: rcs0 [774.914525] Dynamic subtest rcs0: SUCCESS (0.652s) [774.930092] Starting dynamic subtest: bcs0 [775.567226] Dynamic subtest bcs0: SUCCESS (0.651s) [775.583353] Starting dynamic subtest: vcs0 [776.821952] Dynamic subtest vcs0: SUCCESS (1.251s) [776.840040] Starting dynamic subtest: vcs1 [778.869542] Dynamic subtest vcs1: SUCCESS (2.045s) [778.882241] Starting dynamic subtest: vecs0 [780.853860] Dynamic subtest vecs0: SUCCESS (1.983s) [780.867951] Starting dynamic subtest: ccs0 [781.512749] Dynamic subtest ccs0: SUCCESS (0.657s) [781.515399] Subtest busy-idle-check-all: SUCCESS (7.255s) [781.648416] [147/156] (261s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [781.743269] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [781.747341] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [781.846369] [148/156] (261s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt) [781.941898] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt [781.946235] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [782.033755] [149/156] (261s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [782.117442] Starting subtest: primary-yf-tiled-reflect-x-0 [782.188007] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.070s) [782.294513] [150/156] (260s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [782.400888] Starting subtest: fbc-2p-pri-indfb-multidraw [782.404945] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [782.484954] [151/156] (260s left) kms_flip (2x-plain-flip) [782.585605] Starting subtest: 2x-plain-flip [782.595242] Subtest 2x-plain-flip: SKIP (0.011s) [782.676994] [152/156] (260s left) kms_pipe_stress (stress-xrgb8888-ytiled) [782.774184] Starting subtest: stress-xrgb8888-ytiled [782.777834] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [782.875806] [153/156] (260s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite) [782.967096] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite [782.970454] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [783.060999] [154/156] (260s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render) [783.153430] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render [790.456806] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.305s) [790.600472] [155/156] (252s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [790.695206] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [790.699363] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [790.797743] [156/156] (252s left) gem_exec_balancer (bonded-true-hang) [791.053850] Starting subtest: bonded-true-hang [791.059244] Subtest bonded-true-hang: SKIP (0.000s) [791.159682] Closing watchdogs results: parsing output: 0/ for test: kms_ccs results: parsing output: 1/ for test: kms_psr results: parsing output: 2/ for test: api_intel_bb results: parsing output: 3/ for test: vgem_basic results: parsing output: 4/ for test: gem_create results: parsing output: 5/ for test: gen7_exec_parse results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: gem_mmap_gtt results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_exec_balancer results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_exec_await results: parsing output: 15/ for test: gem_ctx_persistence results: parsing output: 16/ for test: kms_busy results: parsing output: 17/ for test: kms_ccs results: parsing output: 18/ for test: gem_ctx_isolation results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_plane_multiple results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_pm_rpm results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: kms_cursor_edge_walk results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: i915_query results: parsing output: 27/ for test: kms_plane_scaling results: parsing output: 28/ for test: kms_cursor_legacy results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: kms_psr results: parsing output: 31/ for test: gem_sync results: parsing output: 32/ for test: kms_big_fb results: parsing output: 33/ for test: kms_rotation_crc results: parsing output: 34/ for test: perf_pmu results: parsing output: 35/ for test: kms_async_flips results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_lease results: parsing output: 38/ for test: gem_exec_fence results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: prime_mmap results: parsing output: 41/ for test: gem_exec_create results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_schedule results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_chamelium_color results: parsing output: 47/ for test: kms_flip_scaled_crc results: parsing output: 48/ for test: syncobj_timeline results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_ccs results: parsing output: 51/ for test: gem_pxp results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: syncobj_wait results: parsing output: 54/ for test: fbdev results: parsing output: 55/ for test: gem_exec_reloc results: parsing output: 56/ for test: kms_flip_scaled_crc results: parsing output: 57/ for test: sw_sync results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_lease results: parsing output: 67/ for test: gem_lmem_swapping results: parsing output: 68/ for test: kms_chamelium_hpd results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: i915_drm_fdinfo results: parsing output: 71/ for test: kms_rmfb results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_pm_rpm results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_ctx_shared results: parsing output: 78/ for test: api_intel_allocator results: parsing output: 79/ for test: kms_content_protection results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: kms_psr_stress_test results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: syncobj_basic results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: kms_color results: parsing output: 86/ for test: gem_render_copy results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: sysfs_preempt_timeout results: parsing output: 89/ for test: gem_spin_batch results: parsing output: 90/ for test: kms_plane results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: gem_exec_params results: parsing output: 93/ for test: kms_explicit_fence results: parsing output: 94/ for test: kms_getfb results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_mmap_wc results: parsing output: 98/ for test: gem_eio results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: prime_mmap results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: syncobj_wait results: parsing output: 103/ for test: gem_userptr_blits results: parsing output: 104/ for test: gem_workarounds results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: kms_psr results: parsing output: 107/ for test: gem_exec_whisper results: parsing output: 108/ for test: gen7_exec_parse results: parsing output: 109/ for test: intel_hwmon results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_psr2_sf results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_render_copy results: parsing output: 114/ for test: gem_userptr_blits results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: template results: parsing output: 117/ for test: gem_exec_flush results: parsing output: 118/ for test: kms_async_flips results: parsing output: 119/ for test: kms_plane results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: kms_flip_scaled_crc results: parsing output: 122/ for test: i915_pm_rpm results: parsing output: 123/ for test: kms_vblank results: parsing output: 124/ for test: sriov_basic results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: syncobj_timeline results: parsing output: 127/ for test: vgem_basic results: parsing output: 128/ for test: gem_ctx_exec results: parsing output: 129/ for test: gem_exec_reloc results: parsing output: 130/ for test: perf results: parsing output: 131/ for test: kms_big_fb results: parsing output: 132/ for test: kms_cursor_crc results: parsing output: 133/ for test: kms_psr2_sf results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: i915_pm_freq_api results: parsing output: 136/ for test: gem_exec_whisper results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: gem_exec_schedule results: parsing output: 139/ for test: syncobj_timeline results: parsing output: 140/ for test: core_setmaster results: parsing output: 141/ for test: kms_vblank results: parsing output: 142/ for test: kms_big_fb results: parsing output: 143/ for test: gem_mmap_offset results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: perf_pmu results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_rotation_crc results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_flip results: parsing output: 151/ for test: kms_pipe_stress results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: gem_exec_balancer Done.