[58.221554] Initializing watchdogs
[58.221597]   /dev/watchdog0
[58.234776] [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]
[58.238901] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.240996] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.244384] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[58.328029] Subtest write-snoop: SKIP (0.000s)
[58.396167] [002/133] (960s left) kms_content_protection (content-type-change)
[58.554125] Starting subtest: content-type-change
[58.558695] Subtest content-type-change: SKIP (0.000s)
[58.718574] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[58.812625] Starting subtest: multiplane-rotation
[76.161811] Subtest multiplane-rotation: SUCCESS (17.360s)
[76.307902] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[76.400324] Subtest ctm-red-to-blue: SKIP (0.000s)
[76.442744] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[76.492183] Starting subtest: invalid-reset-one-illegal-handle
[76.494098] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[76.622616] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[76.721744] Starting subtest: disable-crc-after-crtc
[76.723471] Starting dynamic subtest: pipe-A-eDP-1
[78.395732] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.673s)
[78.404410] Starting dynamic subtest: pipe-B-eDP-1
[80.629137] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.233s)
[80.638328] Starting dynamic subtest: pipe-C-eDP-1
[82.892746] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.264s)
[82.901807] Starting dynamic subtest: pipe-D-eDP-1
[85.149992] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.255s)
[85.152396] Subtest disable-crc-after-crtc: SUCCESS (8.429s)
[86.011235] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[86.082415] Subtest tiled-to-tiled: SKIP (0.000s)
[86.164056] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[86.226967] Starting subtest: wait-all-interrupted
[86.327773] Subtest wait-all-interrupted: SUCCESS (0.101s)
[86.423452] [009/133] (932s left) syncobj_wait (wait-all-complex)
[86.476657] Starting subtest: wait-all-complex
[86.689293] Subtest wait-all-complex: SUCCESS (0.213s)
[86.787090] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[86.919794] Starting subtest: reject-modify-context-protection-on
[86.922800] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[87.062885] [011/133] (932s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[87.192349] Starting subtest: cursorA-vs-flipB-varying-size
[87.197053] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[87.356751] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[87.455811] Starting subtest: primary-rotation-90
[87.460222] Subtest primary-rotation-90: SKIP (0.001s)
[87.548032] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[87.619275] Starting subtest: reset-multiple-signaled
[87.621205] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[87.736738] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[87.833059] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[87.836823] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[88.953400] [015/133] (930s left) gem_softpin (noreloc-s3)
[89.028193] Starting subtest: noreloc-S3
[109.130509] Subtest noreloc-S3: SUCCESS (5.418s)
[109.356651] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[109.466313] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[113.957711] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.504s)
[115.174676] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[115.229992] Starting subtest: invalid-ctx-set
[115.232867] Subtest invalid-ctx-set: SUCCESS (0.001s)
[115.341537] [018/133] (904s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[115.401355] Starting subtest: single-wait-all-for-submit-unsubmitted
[115.503382] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[115.604957] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[115.710490] Starting subtest: x-tiled-64bpp-rotate-90
[115.731118] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[115.889570] [020/133] (903s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[115.950054] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[116.017627] [021/133] (903s left) kms_psr (fbc-psr-cursor-plane-move)
[116.126312] Starting subtest: fbc-psr-cursor-plane-move
[116.129070] Starting dynamic subtest: eDP-1
[116.133774] Dynamic subtest eDP-1: SKIP (0.000s)
[116.138802] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[116.224472] [022/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[116.325570] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[117.327189] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.002s)
[117.460573] [023/133] (902s left) kms_flip (2x-flip-vs-rmfb)
[117.559876] Starting subtest: 2x-flip-vs-rmfb
[117.568358] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[117.692825] [024/133] (901s left) kms_plane_cursor (viewport)
[117.790035] Starting subtest: viewport
[117.794245] Starting dynamic subtest: pipe-A-eDP-1-size-64
[120.398686] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.611s)
[120.458997] Starting dynamic subtest: pipe-A-eDP-1-size-128
[123.040853] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.593s)
[123.101602] Starting dynamic subtest: pipe-A-eDP-1-size-256
[125.630545] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[125.977045] Starting dynamic subtest: pipe-B-eDP-1-size-64
[129.113749] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.149s)
[129.176128] Starting dynamic subtest: pipe-B-eDP-1-size-128
[131.670406] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.503s)
[131.731534] Starting dynamic subtest: pipe-B-eDP-1-size-256
[134.190724] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.470s)
[134.544079] Starting dynamic subtest: pipe-C-eDP-1-size-64
[137.382662] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.850s)
[137.420117] Starting dynamic subtest: pipe-C-eDP-1-size-128
[139.573259] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.157s)
[139.610686] Starting dynamic subtest: pipe-C-eDP-1-size-256
[141.718899] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.112s)
[142.048861] Starting dynamic subtest: pipe-D-eDP-1-size-64
[144.862917] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.825s)
[144.899049] Starting dynamic subtest: pipe-D-eDP-1-size-128
[146.996238] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.102s)
[147.039137] Starting dynamic subtest: pipe-D-eDP-1-size-256
[149.186584] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.157s)
[149.506897] Subtest viewport: SUCCESS (31.725s)
[150.364135] [025/133] (869s left) kms_cdclk (mode-transition)
[150.469139] Starting subtest: mode-transition
[150.471972] Starting dynamic subtest: pipe-A-eDP-1
[150.758549] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[150.767237] Starting dynamic subtest: pipe-B-eDP-1
[150.772979] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[150.782299] Starting dynamic subtest: pipe-C-eDP-1
[150.787347] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[150.795484] Starting dynamic subtest: pipe-D-eDP-1
[150.801219] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[150.806239] Subtest mode-transition: SKIP (0.296s)
[151.591708] [026/133] (868s left) gem_exec_balancer (fairslice)
[151.652207] Starting subtest: fairslice
[154.509228] Subtest fairslice: SUCCESS (2.855s)
[155.700703] [027/133] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[155.835205] Starting subtest: basic-flip-before-cursor-varying-size
[156.776335] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.939s)
[157.629890] [028/133] (862s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[157.734291] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[157.736602] Starting dynamic subtest: pipe-A-default-mode
[158.023284] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[158.028034] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.287s)
[158.848653] [029/133] (860s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[158.942029] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[158.944463] Starting dynamic subtest: pipe-A-default-mode
[161.653260] Dynamic subtest pipe-A-default-mode: SUCCESS (2.710s)
[161.656405] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.712s)
[162.547391] [030/133] (857s left) core_getstats (basic)
[162.600648] Starting subtest: basic
[162.603210] Subtest basic: SUCCESS (0.000s)
[162.718876] [031/133] (857s left) kms_rmfb (close-fd)
[162.817082] Starting subtest: close-fd
[162.819331] Starting dynamic subtest: pipe-A-eDP-1
[162.925666] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[162.935810] Starting dynamic subtest: pipe-B-eDP-1
[164.087018] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.161s)
[164.095296] Starting dynamic subtest: pipe-C-eDP-1
[165.227718] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.140s)
[165.235816] Starting dynamic subtest: pipe-D-eDP-1
[166.361111] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[166.363921] Subtest close-fd: SUCCESS (3.547s)
[167.595814] [032/133] (852s left) gem_exec_reloc (basic-gtt-wc)
[167.663314] Subtest basic-gtt-wc: SKIP (0.000s)
[167.742617] [033/133] (852s left) kms_properties (crtc-properties-legacy)
[167.848113] Starting subtest: crtc-properties-legacy
[167.850204] Starting dynamic subtest: pipe-A-eDP-1
[168.285198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s)
[168.295797] Starting dynamic subtest: pipe-B-eDP-1
[169.441803] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s)
[169.452127] Starting dynamic subtest: pipe-C-eDP-1
[170.566070] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[170.575859] Starting dynamic subtest: pipe-D-eDP-1
[171.689379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[171.692175] Subtest crtc-properties-legacy: SUCCESS (3.845s)
[172.527144] [034/133] (847s left) kms_invalid_mode (zero-hdisplay)
[172.631020] Starting subtest: zero-hdisplay
[172.633612] Starting dynamic subtest: pipe-A-eDP-1
[172.928211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[172.937724] Starting dynamic subtest: pipe-B-eDP-1
[172.940074] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[172.948211] Starting dynamic subtest: pipe-C-eDP-1
[172.951102] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[172.959344] Starting dynamic subtest: pipe-D-eDP-1
[172.962346] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[172.965220] Subtest zero-hdisplay: SUCCESS (0.305s)
[173.757129] [035/133] (846s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[173.852775] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[173.855577] Starting dynamic subtest: pipe-A
[174.922613] Dynamic subtest pipe-A: SUCCESS (1.072s)
[174.934703] Starting dynamic subtest: pipe-B
[177.055976] Dynamic subtest pipe-B: SUCCESS (2.133s)
[177.064775] Starting dynamic subtest: pipe-C
[178.230628] Dynamic subtest pipe-C: SUCCESS (1.174s)
[178.240812] Starting dynamic subtest: pipe-D
[179.458219] Dynamic subtest pipe-D: SUCCESS (1.227s)
[179.460977] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.610s)
[180.669834] [036/133] (839s left) kms_pm_rpm (legacy-planes-dpms)
[182.714942] Starting subtest: legacy-planes-dpms
[182.717622] Starting dynamic subtest: plane-63
[190.975812] Dynamic subtest plane-63: SUCCESS (8.267s)
[190.987135] Starting dynamic subtest: plane-93
[199.319489] Dynamic subtest plane-93: SUCCESS (8.343s)
[199.331294] Starting dynamic subtest: plane-123
[207.953989] Dynamic subtest plane-123: SUCCESS (8.630s)
[207.965826] Starting dynamic subtest: plane-133
[216.663733] Dynamic subtest plane-133: SUCCESS (8.704s)
[216.666937] Subtest legacy-planes-dpms: SUCCESS (33.954s)
[217.044385] [037/133] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[217.154212] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[217.159542] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[217.289575] [038/133] (802s left) kms_dirtyfb (default-dirtyfb-ioctl)
[217.387044] Starting subtest: default-dirtyfb-ioctl
[217.389604] Starting dynamic subtest: A-eDP-1
[218.996968] Dynamic subtest A-eDP-1: SUCCESS (1.610s)
[218.999694] Subtest default-dirtyfb-ioctl: SUCCESS (1.611s)
[219.874365] [039/133] (800s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[219.991697] Starting subtest: cursorB-vs-flipA-legacy
[219.996905] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[220.190051] [040/133] (800s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[220.259121] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[220.261895] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[220.396312] [041/133] (799s left) kms_prime (basic-crc-vgem)
[220.541002] Starting subtest: basic-crc-vgem
[220.543507] Starting dynamic subtest: second-to-first
[221.531959] Dynamic subtest second-to-first: SUCCESS (0.991s)
[221.534139] Subtest basic-crc-vgem: SUCCESS (0.994s)
[221.635557] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[221.638855] [042/133] (798s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[221.750235] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[221.819740] [043/133] (798s left) i915_drm_fdinfo (busy)
[221.860107] Starting subtest: busy
[221.862155] Starting dynamic subtest: rcs0
[221.878578] Dynamic subtest rcs0: SKIP (0.019s)
[221.888452] Starting dynamic subtest: bcs0
[221.904585] Dynamic subtest bcs0: SKIP (0.025s)
[221.915118] Starting dynamic subtest: vcs0
[221.921063] Dynamic subtest vcs0: SKIP (0.000s)
[221.937819] Starting dynamic subtest: vcs1
[221.942966] Dynamic subtest vcs1: SKIP (0.000s)
[221.959994] Starting dynamic subtest: vecs0
[221.965132] Dynamic subtest vecs0: SKIP (0.001s)
[221.982123] Starting dynamic subtest: ccs0
[221.987136] Dynamic subtest ccs0: SKIP (0.001s)
[221.991786] Subtest busy: SKIP (0.053s)
[222.033090] [044/133] (798s left) gem_userptr_blits (nohangcheck)
[222.111679] Starting subtest: nohangcheck
[222.375324] Subtest nohangcheck: SUCCESS (0.263s)
[222.511567] [045/133] (798s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[222.607853] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[223.198339] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.592s)
[223.394672] [046/133] (797s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[223.489770] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[223.494330] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[224.608027] [047/133] (795s left) kms_scaling_modes (scaling-mode-full)
[224.710109] Starting subtest: scaling-mode-full
[224.712836] Starting dynamic subtest: pipe-A-eDP-1
[224.804976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[224.813837] Starting dynamic subtest: pipe-B-eDP-1
[226.012766] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.206s)
[226.022247] Starting dynamic subtest: pipe-C-eDP-1
[227.138335] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[227.147099] Starting dynamic subtest: pipe-D-eDP-1
[228.270464] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[228.273220] Subtest scaling-mode-full: SUCCESS (3.563s)
[229.457824] [048/133] (791s left) kms_psr (fbc-pr-basic)
[229.545347] Starting subtest: fbc-pr-basic
[229.550130] Subtest fbc-pr-basic: SKIP (0.000s)
[229.643689] [049/133] (791s left) gem_ringfill (basic-all)
[235.586668] Starting subtest: basic-all
[236.737149] Subtest basic-all: SUCCESS (1.150s)
[237.631444] [050/133] (783s left) gem_exec_whisper (basic-fds-forked-all)
[237.699013] Starting subtest: basic-fds-forked-all
[261.704340] Subtest basic-fds-forked-all: SUCCESS (24.003s)
[261.909653] [051/133] (758s left) api_intel_bb (full-batch)
[261.968091] Starting subtest: full-batch
[261.975982] Subtest full-batch: SUCCESS (0.011s)
[262.086530] [052/133] (758s left) kms_cursor_crc (cursor-sliding-256x85)
[262.343842] Starting subtest: cursor-sliding-256x85
[262.403709] Subtest cursor-sliding-256x85: SKIP (0.052s)
[262.609100] [053/133] (758s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[262.709908] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[262.712353] Starting dynamic subtest: pipe-A-eDP-1
[262.777065] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[262.786290] Starting dynamic subtest: pipe-B-eDP-1
[262.850091] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[262.860329] Starting dynamic subtest: pipe-C-eDP-1
[262.916693] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[262.925253] Starting dynamic subtest: pipe-D-eDP-1
[262.983544] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[262.987805] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[265.005333] [054/133] (755s left) gen9_exec_parse (allowed-single)
[265.071922] Subtest allowed-single: SKIP (0.000s)
[265.145616] [055/133] (755s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[265.235228] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[272.133194] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.903s)
[272.281214] [056/133] (748s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[272.387168] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[272.392239] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[272.502652] [057/133] (748s left) gem_exec_fence (expired-history)
[273.028791] Starting subtest: expired-history
[280.274293] Subtest expired-history: SUCCESS (7.246s)
[281.012874] [058/133] (740s left) kms_psr (fbc-psr-sprite-plane-move)
[281.107684] Starting subtest: fbc-psr-sprite-plane-move
[281.109859] Starting dynamic subtest: eDP-1
[281.114877] Dynamic subtest eDP-1: SKIP (0.000s)
[281.120093] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[281.206757] [059/133] (739s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[281.311327] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[288.052320] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.745s)
[288.207360] [060/133] (732s left) gem_ctx_bad_destroy (double-destroy)
[288.267929] Starting subtest: double-destroy
[288.270601] Subtest double-destroy: SUCCESS (0.000s)
[288.365364] [061/133] (732s left) syncobj_timeline (invalid-signal-illegal-handle)
[288.421339] Starting subtest: invalid-signal-illegal-handle
[288.424164] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[288.566522] [062/133] (732s left) kms_chamelium_hpd (common-hpd-after-suspend)
[288.946639] Subtest common-hpd-after-suspend: SKIP (0.000s)
[289.724384] [063/133] (731s left) kms_frontbuffer_tracking (fbc-tiling-4)
[289.828880] Starting subtest: fbc-tiling-4
[294.090841] Subtest fbc-tiling-4: SUCCESS (4.268s)
[295.269962] [064/133] (726s left) gem_cs_tlb (engines)
[295.334893] Starting subtest: engines
[295.337190] Starting dynamic subtest: rcs0
[297.490176] Dynamic subtest rcs0: SUCCESS (2.152s)
[297.499829] Starting dynamic subtest: bcs0
[299.643180] Dynamic subtest bcs0: SUCCESS (2.153s)
[299.653550] Starting dynamic subtest: vcs0
[301.794692] Dynamic subtest vcs0: SUCCESS (2.152s)
[301.804239] Starting dynamic subtest: vcs1
[303.947631] Dynamic subtest vcs1: SUCCESS (2.152s)
[303.957834] Starting dynamic subtest: vecs0
[306.100154] Dynamic subtest vecs0: SUCCESS (2.152s)
[306.109464] Starting dynamic subtest: ccs0
[308.253227] Dynamic subtest ccs0: SUCCESS (2.152s)
[308.256113] Subtest engines: SUCCESS (12.917s)
[308.411778] [065/133] (712s left) gem_mmap_gtt (hang-busy)
[308.464020] Subtest hang-busy: SKIP (0.000s)
[308.526644] [066/133] (712s left) kms_psr (psr2-sprite-plane-onoff)
[308.627932] Starting subtest: psr2-sprite-plane-onoff
[308.630571] Starting dynamic subtest: eDP-1
[310.331013] Dynamic subtest eDP-1: SUCCESS (1.703s)
[310.333872] Subtest psr2-sprite-plane-onoff: SUCCESS (1.704s)
[311.218605] [067/133] (710s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[311.318925] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[311.931193] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.614s)
[312.162614] [068/133] (709s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[312.275152] Starting subtest: y-tiled-64bpp-rotate-270
[312.280364] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[312.402531] [069/133] (709s left) gem_bad_reloc (negative-reloc-lut)
[312.457722] Subtest negative-reloc-lut: SKIP (0.000s)
[312.525562] [070/133] (709s left) gem_ctx_persistence (engines-mixed)
[312.591688] Starting subtest: engines-mixed
[312.594231] Starting dynamic subtest: rcs0
[312.718559] Dynamic subtest rcs0: SUCCESS (0.127s)
[312.731297] Starting dynamic subtest: bcs0
[312.777223] Dynamic subtest bcs0: SUCCESS (0.057s)
[312.789096] Starting dynamic subtest: vcs0
[312.866136] Dynamic subtest vcs0: SUCCESS (0.087s)
[312.877755] Starting dynamic subtest: vcs1
[312.928127] Dynamic subtest vcs1: SUCCESS (0.060s)
[312.939887] Starting dynamic subtest: vecs0
[313.005216] Dynamic subtest vecs0: SUCCESS (0.075s)
[313.017196] Starting dynamic subtest: ccs0
[313.078044] Dynamic subtest ccs0: SUCCESS (0.071s)
[313.080862] Subtest engines-mixed: SUCCESS (0.488s)
[313.181400] [071/133] (708s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[313.277395] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[313.279755] Starting dynamic subtest: pipe-A
[313.343808] Dynamic subtest pipe-A: SUCCESS (0.068s)
[313.354239] Starting dynamic subtest: pipe-B
[314.511677] Dynamic subtest pipe-B: SUCCESS (1.165s)
[314.523485] Starting dynamic subtest: pipe-C
[315.619496] Dynamic subtest pipe-C: SUCCESS (1.106s)
[315.630565] Starting dynamic subtest: pipe-D
[316.761579] Dynamic subtest pipe-D: SUCCESS (1.141s)
[316.764310] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.488s)
[317.940771] [072/133] (703s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[318.050206] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[318.054665] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[318.169223] [073/133] (703s left) gem_exec_schedule (semaphore-noskip)
[318.250530] Starting subtest: semaphore-noskip
[318.699336] Subtest semaphore-noskip: SUCCESS (0.453s)
[319.060774] [074/133] (702s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[319.156911] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[319.161943] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[319.271832] [075/133] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[319.384074] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[319.389310] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[319.517618] [076/133] (702s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[319.619752] Starting subtest: 4-tiled-16bpp-rotate-0
[320.830153] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.211s)
[320.992339] [077/133] (700s left) gem_exec_basic (basic)
[321.049221] Starting subtest: basic
[321.051631] Starting dynamic subtest: rcs0-smem
[321.053655] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[321.064095] Starting dynamic subtest: bcs0-smem
[321.066122] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[321.074601] Starting dynamic subtest: vcs0-smem
[321.076580] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[321.085149] Starting dynamic subtest: vcs1-smem
[321.087069] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[321.095367] Starting dynamic subtest: vecs0-smem
[321.097253] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[321.106125] Starting dynamic subtest: ccs0-smem
[321.108014] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[321.109771] Subtest basic: SUCCESS (0.016s)
[322.691765] [078/133] (699s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[322.795154] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[322.801004] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[322.909529] [079/133] (699s left) gem_mmap (short-mmap)
[322.973435] Subtest short-mmap: SKIP (0.000s)
[323.044931] [080/133] (698s left) gem_exec_reloc (basic-gtt-wc-active)
[323.096013] Subtest basic-gtt-wc-active: SKIP (0.000s)
[323.165104] [081/133] (698s left) gem_ctx_shared (create-shared-gtt)
[323.227107] Starting subtest: create-shared-gtt
[325.381002] Subtest create-shared-gtt: SUCCESS (2.153s)
[325.799792] [082/133] (696s left) gem_exec_reloc (basic-write-wc)
[325.872181] Subtest basic-write-wc: SKIP (0.000s)
[325.954197] [083/133] (696s left) gem_eio (wait-immediate)
[326.200107] Starting subtest: wait-immediate
[326.611198] Subtest wait-immediate: SUCCESS (0.410s)
[326.796619] [084/133] (695s left) gem_ctx_persistence (legacy-engines-mixed)
[326.857863] Starting subtest: legacy-engines-mixed
[326.860119] Starting dynamic subtest: render
[326.963096] Dynamic subtest render: SUCCESS (0.105s)
[326.973999] Starting dynamic subtest: bsd1
[327.030313] Dynamic subtest bsd1: SUCCESS (0.065s)
[327.044012] Starting dynamic subtest: bsd2
[327.103224] Dynamic subtest bsd2: SUCCESS (0.070s)
[327.116892] Starting dynamic subtest: blt
[327.178252] Dynamic subtest blt: SUCCESS (0.072s)
[327.193743] Starting dynamic subtest: vebox
[327.247251] Dynamic subtest vebox: SUCCESS (0.066s)
[327.250049] Subtest legacy-engines-mixed: SUCCESS (0.391s)
[327.348822] [085/133] (694s left) perf_pmu (semaphore-busy)
[327.388030] Starting subtest: semaphore-busy
[327.390064] Starting dynamic subtest: rcs0
[329.033298] Dynamic subtest rcs0: SUCCESS (1.641s)
[329.047332] Starting dynamic subtest: bcs0
[330.665777] Dynamic subtest bcs0: SUCCESS (1.630s)
[330.678493] Starting dynamic subtest: vcs0
[335.095502] Dynamic subtest vcs0: SUCCESS (4.425s)
[335.108618] Starting dynamic subtest: vcs1
[341.112649] Dynamic subtest vcs1: SUCCESS (6.012s)
[341.125309] Starting dynamic subtest: vecs0
[347.127291] Dynamic subtest vecs0: SUCCESS (6.011s)
[347.140318] Starting dynamic subtest: ccs0
[350.202568] Dynamic subtest ccs0: SUCCESS (3.072s)
[350.205629] Subtest semaphore-busy: SUCCESS (22.807s)
[350.341514] [086/133] (671s left) gem_exec_schedule (pi-common)
[350.533193] Starting subtest: pi-common
[350.535556] Starting dynamic subtest: rcs0
[350.573835] Dynamic subtest rcs0: SUCCESS (0.043s)
[350.589741] Starting dynamic subtest: bcs0
[350.624076] Dynamic subtest bcs0: SUCCESS (0.049s)
[350.641941] Starting dynamic subtest: vcs0
[350.663800] Dynamic subtest vcs0: SUCCESS (0.038s)
[350.675165] Starting dynamic subtest: vcs1
[350.699798] Dynamic subtest vcs1: SUCCESS (0.035s)
[350.709205] Starting dynamic subtest: vecs0
[350.735160] Dynamic subtest vecs0: SUCCESS (0.035s)
[350.744745] Starting dynamic subtest: ccs0
[350.770101] Dynamic subtest ccs0: SUCCESS (0.034s)
[350.772795] Subtest pi-common: SUCCESS (0.240s)
[351.017094] [087/133] (671s left) i915_hangman (engine-error-state-capture)
[351.094319] Starting subtest: engine-error-state-capture
[351.097125] Starting dynamic subtest: rcs0
[354.586252] Dynamic subtest rcs0: SUCCESS (3.492s)
[354.599375] Starting dynamic subtest: bcs0
[360.539243] Dynamic subtest bcs0: SUCCESS (5.949s)
[360.552942] Starting dynamic subtest: vcs0
[366.556623] Dynamic subtest vcs0: SUCCESS (6.014s)
[366.569665] Starting dynamic subtest: vcs1
[372.570925] Dynamic subtest vcs1: SUCCESS (6.010s)
[372.584317] Starting dynamic subtest: vecs0
[378.522639] Dynamic subtest vecs0: SUCCESS (5.949s)
[378.536028] Starting dynamic subtest: ccs0
[384.538992] Dynamic subtest ccs0: SUCCESS (6.013s)
[384.542210] Subtest engine-error-state-capture: SUCCESS (33.443s)
[384.647613] [088/133] (637s left) syncobj_timeline (wait-for-submit-snapshot)
[384.704331] Starting subtest: wait-for-submit-snapshot
[384.784959] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[384.895430] [089/133] (637s left) kms_color (ctm-blue-to-red)
[384.992899] Starting subtest: ctm-blue-to-red
[384.995124] Starting dynamic subtest: pipe-A-eDP-1
[385.699727] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[385.709484] Starting dynamic subtest: pipe-B-eDP-1
[387.094193] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.394s)
[387.105257] Starting dynamic subtest: pipe-C-eDP-1
[388.375648] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.282s)
[388.386056] Starting dynamic subtest: pipe-D-eDP-1
[389.708332] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[389.711303] Subtest ctm-blue-to-red: SUCCESS (4.713s)
[390.584797] [090/133] (631s left) prime_vgem (basic-gtt)
[390.673015] Starting subtest: basic-gtt
[390.678623] Subtest basic-gtt: SKIP (0.000s)
[390.792230] [091/133] (631s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[390.881805] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[398.239367] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.360s)
[398.390700] [092/133] (624s left) api_intel_allocator (default-alignment)
[398.446198] Starting subtest: default-alignment
[398.451334] Subtest default-alignment: SUCCESS (0.005s)
[398.611480] [093/133] (623s left) i915_pm_rps (fence-order)
[398.673576] Starting subtest: fence-order
[401.541140] Subtest fence-order: SUCCESS (2.869s)
[401.707563] [094/133] (620s left) kms_vblank (query-busy)
[401.808986] Starting subtest: query-busy
[401.811436] Starting dynamic subtest: pipe-A-eDP-1
[403.691898] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.883s)
[403.706110] Starting dynamic subtest: pipe-D-eDP-1
[406.255627] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.560s)
[406.257937] Subtest query-busy: SUCCESS (4.447s)
[407.074256] [095/133] (615s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[407.173664] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[407.178179] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[407.295795] [096/133] (615s left) kms_addfb_basic (invalid-get-prop-any)
[407.366328] Starting subtest: invalid-get-prop-any
[407.368286] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[407.529335] [097/133] (615s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[407.628766] Starting subtest: fbc-psr2-cursor-mmap-gtt
[407.631124] Starting dynamic subtest: eDP-1
[407.636097] Dynamic subtest eDP-1: SKIP (0.000s)
[407.641188] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[407.722029] [098/133] (615s left) kms_flip (2x-blocking-absolute-wf_vblank)
[407.823015] Starting subtest: 2x-blocking-absolute-wf_vblank
[407.834077] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s)
[407.947687] [099/133] (614s left) kms_cursor_crc (cursor-onscreen-256x85)
[408.208790] Starting subtest: cursor-onscreen-256x85
[408.254157] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[408.467572] [100/133] (614s left) kms_flip (2x-modeset-vs-vblank-race)
[408.567953] Starting subtest: 2x-modeset-vs-vblank-race
[408.578610] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[408.679742] [101/133] (614s left) kms_atomic_interruptible (atomic-setmode)
[408.775533] Starting subtest: atomic-setmode
[408.777316] Starting dynamic subtest: pipe-A-eDP-1
[415.680959] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.905s)
[415.683568] Subtest atomic-setmode: SUCCESS (6.907s)
[416.583030] [102/133] (606s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[416.682533] Starting subtest: psr-argb161616f-draw-render
[416.687259] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[416.817642] [103/133] (606s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[416.931886] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[416.937208] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[417.071819] [104/133] (605s left) kms_plane_scaling (invalid-num-scalers)
[417.168073] Starting subtest: invalid-num-scalers
[417.170722] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[417.186042] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[417.196526] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[417.217940] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[417.228232] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[417.249741] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[417.260003] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[417.278114] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[417.280940] Subtest invalid-num-scalers: SUCCESS (0.113s)
[417.411977] [105/133] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[417.496090] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[417.500041] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[417.630336] [106/133] (605s left) sw_sync (alloc_fence_invalid_timeline)
[417.665832] Starting subtest: alloc_fence_invalid_timeline
[417.668222] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[417.750662] [107/133] (605s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[417.826338] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[417.926486] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[418.027213] [108/133] (605s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[418.126482] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[418.128129] Starting dynamic subtest: A-eDP1
[427.001876] Dynamic subtest A-eDP1: SUCCESS (8.874s)
[427.015326] Starting dynamic subtest: B-eDP1
[435.927975] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[435.939539] Starting dynamic subtest: C-eDP1
[444.874122] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[444.885543] Starting dynamic subtest: D-eDP1
[453.786113] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[453.791810] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.665s)
[455.041674] [109/133] (568s left) kms_addfb_basic (size-max)
[455.155169] Starting subtest: size-max
[455.157533] Subtest size-max: SUCCESS (0.000s)
[455.288523] [110/133] (567s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[455.540093] Starting subtest: cursor-rapid-movement-256x256
[455.542698] Starting dynamic subtest: pipe-A-eDP-1
[456.134999] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.591s)
[456.167321] Starting dynamic subtest: pipe-D-eDP-1
[457.312209] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.154s)
[457.315030] Subtest cursor-rapid-movement-256x256: SUCCESS (1.772s)
[458.200668] [111/133] (565s left) gem_exec_whisper (basic-queues-all)
[458.268609] Starting subtest: basic-queues-all
[465.846138] Subtest basic-queues-all: SUCCESS (7.576s)
[466.059917] [112/133] (557s left) kms_dsc (dsc-fractional-bpp)
[466.157461] Starting subtest: dsc-fractional-bpp
[466.172761] Subtest dsc-fractional-bpp: SKIP (0.000s)
[466.255135] [113/133] (557s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[466.346338] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[466.348767] Starting dynamic subtest: pipe-A-default-mode
[466.646008] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[466.651058] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.299s)
[467.516769] [114/133] (555s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[467.619753] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[467.625098] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[467.744788] [115/133] (555s left) gem_softpin (evict-prime)
[467.812095] Starting subtest: evict-prime
[467.814468] Starting dynamic subtest: rcs0
[469.006026] Dynamic subtest rcs0: SUCCESS (1.195s)
[469.018755] Starting dynamic subtest: bcs0
[470.158587] Dynamic subtest bcs0: SUCCESS (1.151s)
[470.171314] Starting dynamic subtest: vcs0
[471.582765] Dynamic subtest vcs0: SUCCESS (1.421s)
[471.596315] Starting dynamic subtest: vcs1
[473.560653] Dynamic subtest vcs1: SUCCESS (1.976s)
[473.574065] Starting dynamic subtest: vecs0
[475.613225] Dynamic subtest vecs0: SUCCESS (2.050s)
[475.626893] Starting dynamic subtest: ccs0
[476.769133] Dynamic subtest ccs0: SUCCESS (1.154s)
[476.782566] Starting dynamic subtest: all
[478.622166] Dynamic subtest all: SUCCESS (1.850s)
[478.625243] Subtest evict-prime: SUCCESS (10.812s)
[478.726058] [116/133] (544s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[478.852970] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[478.857757] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[478.980442] [117/133] (544s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[479.069800] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[479.192700] [118/133] (544s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[479.246203] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[479.352475] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[479.457037] [119/133] (544s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[479.556591] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[479.561948] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[479.689735] [120/133] (543s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[479.787173] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[483.924229] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.141s)
[485.117696] [121/133] (538s left) gem_mmap_wc (bad-size)
[485.175152] Subtest bad-size: SKIP (0.000s)
[485.245536] [122/133] (538s left) kms_hdr (static-toggle-suspend)
[485.340161] Starting subtest: static-toggle-suspend
[485.348338] Subtest static-toggle-suspend: SKIP (0.000s)
[485.435677] [123/133] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[485.532061] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[485.536952] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[485.666589] [124/133] (538s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[490.667237] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[490.670067] Starting dynamic subtest: pipe-A-eDP-1
[491.466963] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s)
[491.478123] Starting dynamic subtest: pipe-B-eDP-1
[492.599085] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[492.603563] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.929s)
[493.805650] [125/133] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[493.912576] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[493.917254] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[494.034952] [126/133] (529s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[494.143804] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[494.146220] Starting dynamic subtest: pipe-A-eDP-1
[494.167053] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[494.178471] Starting dynamic subtest: pipe-B-eDP-1
[494.201064] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[494.210856] Starting dynamic subtest: pipe-C-eDP-1
[494.233538] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[494.243229] Starting dynamic subtest: pipe-D-eDP-1
[494.267040] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[494.269761] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[496.478513] [127/133] (527s left) syncobj_timeline (single-wait-all-available-submitted)
[496.546787] Starting subtest: single-wait-all-available-submitted
[496.549121] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[496.661519] [128/133] (527s left) gem_exec_parallel (userptr)
[496.730329] Starting subtest: userptr
[496.733079] Starting dynamic subtest: rcs0
[498.530208] Dynamic subtest rcs0: SUCCESS (1.799s)
[498.541006] Starting dynamic subtest: bcs0
[500.252223] Dynamic subtest bcs0: SUCCESS (1.720s)
[500.263188] Starting dynamic subtest: vcs0
[503.612338] Dynamic subtest vcs0: SUCCESS (3.357s)
[503.624501] Starting dynamic subtest: vcs1
[505.596077] Dynamic subtest vcs1: SUCCESS (1.981s)
[505.608734] Starting dynamic subtest: vecs0
[507.579968] Dynamic subtest vecs0: SUCCESS (1.981s)
[507.593638] Starting dynamic subtest: ccs0
[509.406522] Dynamic subtest ccs0: SUCCESS (1.827s)
[509.409298] Subtest userptr: SUCCESS (12.678s)
[509.619238] [129/133] (514s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[509.731383] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[509.736315] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[509.854664] [130/133] (514s left) i915_selftest (mock)
[511.798061] Starting subtest: mock
[511.800721] Starting dynamic subtest: sanitycheck
[513.876292] Dynamic subtest sanitycheck: SUCCESS (2.078s)
[513.892092] Starting dynamic subtest: shmem
[515.967027] Dynamic subtest shmem: SUCCESS (2.089s)
[515.976888] Starting dynamic subtest: fence
[524.757735] Dynamic subtest fence: SUCCESS (8.790s)
[524.767460] Starting dynamic subtest: scatterlist
[527.735773] Dynamic subtest scatterlist: SUCCESS (2.976s)
[527.750822] Starting dynamic subtest: syncmap
[532.275608] Dynamic subtest syncmap: SUCCESS (4.538s)
[532.286683] Starting dynamic subtest: uncore
[534.333822] Dynamic subtest uncore: SUCCESS (2.056s)
[534.343235] Starting dynamic subtest: ring
[536.361489] Dynamic subtest ring: SUCCESS (2.026s)
[536.376768] Starting dynamic subtest: engine
[538.396311] Dynamic subtest engine: SUCCESS (2.033s)
[538.405079] Starting dynamic subtest: timelines
[543.636753] Dynamic subtest timelines: SUCCESS (5.239s)
[543.646641] Starting dynamic subtest: requests
[548.497096] Dynamic subtest requests: SUCCESS (4.859s)
[548.507320] Starting dynamic subtest: objects
[550.718326] Dynamic subtest objects: SUCCESS (2.220s)
[550.733304] Starting dynamic subtest: phys
[552.850951] Dynamic subtest phys: SUCCESS (2.131s)
[552.861658] Starting dynamic subtest: dmabuf
[555.004925] Dynamic subtest dmabuf: SUCCESS (2.152s)
[555.014947] Starting dynamic subtest: vma
[561.349730] Dynamic subtest vma: SUCCESS (6.343s)
[561.360147] Starting dynamic subtest: evict
[564.101631] Dynamic subtest evict: SUCCESS (2.750s)
[564.111824] Starting dynamic subtest: gtt
[568.617637] Dynamic subtest gtt: SUCCESS (4.515s)
[568.632394] Starting dynamic subtest: hugepages
[570.869568] Dynamic subtest hugepages: SUCCESS (2.250s)
[570.879192] Starting dynamic subtest: memory_region
[574.870061] Dynamic subtest memory_region: SUCCESS (3.999s)
[574.873294] Subtest mock: SUCCESS (63.081s)
[574.903494] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[574.904160] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[574.907792] [131/133] (449s left) gem_mmap_gtt (basic-write-read)
[577.747939] Subtest basic-write-read: SKIP (0.000s)
[577.812665] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[577.813983] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[577.818012] [132/133] (446s left) perf (gen12-group-exclusive-stream-sample-oa)
[577.961294] Starting subtest: gen12-group-exclusive-stream-sample-oa
[577.981239] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.019s)
[578.022552] [133/133] (446s left) perf_pmu (busy-double-start)
[578.061879] Starting subtest: busy-double-start
[578.064680] Starting dynamic subtest: rcs0
[581.724210] Dynamic subtest rcs0: FAIL (3.593s)
[581.734990] Starting dynamic subtest: bcs0
[585.225608] Dynamic subtest bcs0: SUCCESS (3.572s)
[585.236599] Starting dynamic subtest: vcs0
[589.170680] Dynamic subtest vcs0: SUCCESS (3.942s)
[589.183410] Starting dynamic subtest: vcs1
[593.127334] Dynamic subtest vcs1: SUCCESS (3.953s)
[593.140063] Starting dynamic subtest: vecs0
[597.123328] Dynamic subtest vecs0: SUCCESS (3.993s)
[597.135498] Starting dynamic subtest: ccs0
[600.778123] Dynamic subtest ccs0: FAIL (3.565s)
[600.781176] Subtest busy-double-start: FAIL (22.629s)
[600.821159] Closing watchdogs
results: parsing output: 0/ for test: gem_partial_pwrite_pread
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: gem_set_tiling_vs_blt
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_pxp
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_plane_cursor
results: parsing output: 24/ for test: kms_cdclk
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: core_getstats
results: parsing output: 30/ for test: kms_rmfb
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_dirtyfb
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_prime
results: parsing output: 41/ for test: kms_pipe_b_c_ivb
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_scaling_modes
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_ringfill
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_bad_destroy
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_cs_tlb
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_bad_reloc
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_color
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: i915_pm_rps
results: parsing output: 93/ for test: kms_vblank
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_atomic_interruptible
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_exec_whisper
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_hdr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_exec_parallel
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: i915_selftest
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: perf_pmu
Done.