[59.586996] Initializing watchdogs
[59.587060]   /dev/watchdog0
[59.601917] [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]
[59.606376] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.608566] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.611812] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[59.713370] Subtest write-snoop: SKIP (0.000s)
[59.798916] [002/133] (960s left) kms_content_protection (content-type-change)
[59.952994] Starting subtest: content-type-change
[59.957280] Subtest content-type-change: SKIP (0.000s)
[60.108622] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[60.206057] Starting subtest: multiplane-rotation
[77.588954] Subtest multiplane-rotation: SUCCESS (17.392s)
[77.747767] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[77.849954] Subtest ctm-red-to-blue: SKIP (0.000s)
[77.890931] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[77.956272] Starting subtest: invalid-reset-one-illegal-handle
[77.958262] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[78.095948] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[78.200460] Starting subtest: disable-crc-after-crtc
[78.202268] Starting dynamic subtest: pipe-A-eDP-1
[79.867343] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.664s)
[79.876858] Starting dynamic subtest: pipe-B-eDP-1
[82.136991] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.269s)
[82.146119] Starting dynamic subtest: pipe-C-eDP-1
[84.377680] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.239s)
[84.386075] Starting dynamic subtest: pipe-D-eDP-1
[86.643170] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.263s)
[86.645388] Subtest disable-crc-after-crtc: SUCCESS (8.441s)
[87.488443] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[87.564936] Subtest tiled-to-tiled: SKIP (0.000s)
[87.653756] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[87.718667] Starting subtest: wait-all-interrupted
[87.825404] Subtest wait-all-interrupted: SUCCESS (0.107s)
[87.925798] [009/133] (932s left) syncobj_wait (wait-all-complex)
[87.984660] Starting subtest: wait-all-complex
[88.196782] Subtest wait-all-complex: SUCCESS (0.212s)
[88.292215] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[88.431862] Starting subtest: reject-modify-context-protection-on
[88.434323] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[88.581701] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[88.710327] Starting subtest: cursorA-vs-flipB-varying-size
[88.714956] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[88.879904] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[88.979501] Starting subtest: primary-rotation-90
[88.984101] Subtest primary-rotation-90: SKIP (0.001s)
[89.077247] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[89.144046] Starting subtest: reset-multiple-signaled
[89.146260] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[89.262180] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[89.354279] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[89.357977] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[90.515888] [015/133] (930s left) gem_softpin (noreloc-s3)
[90.587068] Starting subtest: noreloc-S3
[111.166355] Subtest noreloc-S3: SUCCESS (5.386s)
[118.403704] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[118.530511] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[122.977000] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.478s)
[124.187942] [017/133] (903s left) gem_ctx_param (invalid-ctx-set)
[124.236504] Starting subtest: invalid-ctx-set
[124.238864] Subtest invalid-ctx-set: SUCCESS (0.001s)
[124.371757] [018/133] (903s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[124.430184] Starting subtest: single-wait-all-for-submit-unsubmitted
[124.536223] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[124.638085] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[124.758063] Starting subtest: x-tiled-64bpp-rotate-90
[124.777958] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[124.943355] [020/133] (902s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[125.005752] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[125.072648] [021/133] (902s left) kms_psr (fbc-psr-cursor-plane-move)
[125.173008] Starting subtest: fbc-psr-cursor-plane-move
[125.175200] Starting dynamic subtest: eDP-1
[125.179098] Dynamic subtest eDP-1: SKIP (0.000s)
[125.182982] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[125.269092] [022/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[125.369447] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[126.422132] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.056s)
[126.590826] [023/133] (901s left) kms_flip (2x-flip-vs-rmfb)
[126.694279] Starting subtest: 2x-flip-vs-rmfb
[126.706469] Subtest 2x-flip-vs-rmfb: SKIP (0.012s)
[126.807525] [024/133] (901s left) kms_plane_cursor (viewport)
[126.888179] Starting subtest: viewport
[126.891833] Starting dynamic subtest: pipe-A-eDP-1-size-64
[129.477792] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.595s)
[129.535884] Starting dynamic subtest: pipe-A-eDP-1-size-128
[132.072657] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s)
[132.132201] Starting dynamic subtest: pipe-A-eDP-1-size-256
[134.824832] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.704s)
[135.171039] Starting dynamic subtest: pipe-B-eDP-1-size-64
[138.477651] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.319s)
[138.537616] Starting dynamic subtest: pipe-B-eDP-1-size-128
[141.066609] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.537s)
[141.124636] Starting dynamic subtest: pipe-B-eDP-1-size-256
[143.686727] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[144.047373] Starting dynamic subtest: pipe-C-eDP-1-size-64
[146.990247] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.956s)
[147.026861] Starting dynamic subtest: pipe-C-eDP-1-size-128
[149.156223] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.136s)
[149.194129] Starting dynamic subtest: pipe-C-eDP-1-size-256
[151.357196] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[151.687057] Starting dynamic subtest: pipe-D-eDP-1-size-64
[154.581209] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.905s)
[154.618291] Starting dynamic subtest: pipe-D-eDP-1-size-128
[156.815120] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.202s)
[156.851836] Starting dynamic subtest: pipe-D-eDP-1-size-256
[159.026102] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[159.360742] Subtest viewport: SUCCESS (32.498s)
[160.189447] [025/133] (867s left) kms_cdclk (mode-transition)
[160.291094] Starting subtest: mode-transition
[160.293411] Starting dynamic subtest: pipe-A-eDP-1
[160.592839] Dynamic subtest pipe-A-eDP-1: SKIP (0.298s)
[160.601915] Starting dynamic subtest: pipe-B-eDP-1
[160.606632] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[160.617089] Starting dynamic subtest: pipe-C-eDP-1
[160.621603] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[160.629759] Starting dynamic subtest: pipe-D-eDP-1
[160.633877] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[160.637847] Subtest mode-transition: SKIP (0.306s)
[161.422326] [026/133] (866s left) gem_exec_balancer (fairslice)
[161.495493] Starting subtest: fairslice
[164.386843] Subtest fairslice: SUCCESS (2.890s)
[165.230759] [027/133] (862s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[165.372475] Starting subtest: basic-flip-before-cursor-varying-size
[166.288975] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.914s)
[167.163182] [028/133] (861s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[167.263993] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[167.266243] Starting dynamic subtest: pipe-A-default-mode
[167.557306] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[167.569268] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.289s)
[168.397630] [029/133] (859s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[168.500053] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[168.502237] Starting dynamic subtest: pipe-A-default-mode
[171.232002] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[171.234481] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.735s)
[172.089776] [030/133] (856s left) core_getstats (basic)
[172.150211] Starting subtest: basic
[172.152118] Subtest basic: SUCCESS (0.000s)
[172.264708] [031/133] (856s left) kms_rmfb (close-fd)
[172.364090] Starting subtest: close-fd
[172.366370] Starting dynamic subtest: pipe-A-eDP-1
[172.471623] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[172.481402] Starting dynamic subtest: pipe-B-eDP-1
[173.639281] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[173.649158] Starting dynamic subtest: pipe-C-eDP-1
[174.765990] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[174.774666] Starting dynamic subtest: pipe-D-eDP-1
[175.900869] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[175.903203] Subtest close-fd: SUCCESS (3.538s)
[177.125011] [032/133] (851s left) gem_exec_reloc (basic-gtt-wc)
[177.191891] Subtest basic-gtt-wc: SKIP (0.000s)
[177.263761] [033/133] (851s left) kms_properties (crtc-properties-legacy)
[177.350887] Starting subtest: crtc-properties-legacy
[177.353201] Starting dynamic subtest: pipe-A-eDP-1
[177.801297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[177.811083] Starting dynamic subtest: pipe-B-eDP-1
[178.963214] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.159s)
[178.971974] Starting dynamic subtest: pipe-C-eDP-1
[180.081093] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[180.090524] Starting dynamic subtest: pipe-D-eDP-1
[181.217079] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[181.219501] Subtest crtc-properties-legacy: SUCCESS (3.868s)
[182.050355] [034/133] (846s left) kms_invalid_mode (zero-hdisplay)
[182.154279] Starting subtest: zero-hdisplay
[182.156454] Starting dynamic subtest: pipe-A-eDP-1
[182.438478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[182.447511] Starting dynamic subtest: pipe-B-eDP-1
[182.449499] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[182.457419] Starting dynamic subtest: pipe-C-eDP-1
[182.459356] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[182.467671] Starting dynamic subtest: pipe-D-eDP-1
[182.469971] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[182.472191] Subtest zero-hdisplay: SUCCESS (0.292s)
[183.286052] [035/133] (845s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[183.383129] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[183.385537] Starting dynamic subtest: pipe-A
[184.429728] Dynamic subtest pipe-A: SUCCESS (1.050s)
[184.437844] Starting dynamic subtest: pipe-B
[186.594618] Dynamic subtest pipe-B: SUCCESS (2.164s)
[186.610450] Starting dynamic subtest: pipe-C
[187.768989] Dynamic subtest pipe-C: SUCCESS (1.172s)
[187.780938] Starting dynamic subtest: pipe-D
[189.009356] Dynamic subtest pipe-D: SUCCESS (1.237s)
[189.011790] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.631s)
[190.227723] [036/133] (838s left) kms_pm_rpm (legacy-planes-dpms)
[192.268190] Starting subtest: legacy-planes-dpms
[192.271289] Starting dynamic subtest: plane-63
[200.691918] Dynamic subtest plane-63: SUCCESS (8.426s)
[200.703021] Starting dynamic subtest: plane-93
[209.267490] Dynamic subtest plane-93: SUCCESS (8.576s)
[209.280507] Starting dynamic subtest: plane-123
[217.887825] Dynamic subtest plane-123: SUCCESS (8.616s)
[217.899217] Starting dynamic subtest: plane-133
[226.478867] Dynamic subtest plane-133: SUCCESS (8.585s)
[226.481735] Subtest legacy-planes-dpms: SUCCESS (34.214s)
[226.864637] [037/133] (801s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[226.969675] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[226.973907] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[227.112788] [038/133] (801s left) kms_dirtyfb (default-dirtyfb-ioctl)
[227.195819] Starting subtest: default-dirtyfb-ioctl
[227.197997] Starting dynamic subtest: A-eDP-1
[228.767611] Dynamic subtest A-eDP-1: SUCCESS (1.572s)
[228.769938] Subtest default-dirtyfb-ioctl: SUCCESS (1.574s)
[229.595248] [039/133] (799s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[229.729358] Starting subtest: cursorB-vs-flipA-legacy
[229.733633] Subtest cursorB-vs-flipA-legacy: SKIP (0.003s)
[229.916335] [040/133] (798s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[229.977111] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[229.979039] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[230.106894] [041/133] (798s left) kms_prime (basic-crc-vgem)
[230.226902] Starting subtest: basic-crc-vgem
[230.229139] Starting dynamic subtest: second-to-first
[231.142609] Dynamic subtest second-to-first: SUCCESS (0.917s)
[231.144672] Subtest basic-crc-vgem: SUCCESS (0.918s)
[231.258443] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[231.261352] [042/133] (797s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[231.345087] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[231.406638] [043/133] (797s left) i915_drm_fdinfo (busy)
[231.449561] Starting subtest: busy
[231.451583] Starting dynamic subtest: rcs0
[231.488330] Dynamic subtest rcs0: SKIP (0.036s)
[231.498853] Starting dynamic subtest: bcs0
[231.502476] Dynamic subtest bcs0: SKIP (0.001s)
[231.510901] Starting dynamic subtest: vcs0
[231.514316] Dynamic subtest vcs0: SKIP (0.000s)
[231.522689] Starting dynamic subtest: vcs1
[231.526244] Dynamic subtest vcs1: SKIP (0.000s)
[231.534275] Starting dynamic subtest: vecs0
[231.537791] Dynamic subtest vecs0: SKIP (0.000s)
[231.545852] Starting dynamic subtest: ccs0
[231.549352] Dynamic subtest ccs0: SKIP (0.000s)
[231.552969] Subtest busy: SKIP (0.045s)
[231.588803] [044/133] (797s left) gem_userptr_blits (nohangcheck)
[231.662192] Starting subtest: nohangcheck
[231.906483] Subtest nohangcheck: SUCCESS (0.240s)
[232.071901] [045/133] (796s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[232.177698] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[232.790834] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.614s)
[232.968024] [046/133] (795s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[233.077320] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[233.081932] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[234.229164] [047/133] (794s left) kms_scaling_modes (scaling-mode-full)
[234.328286] Starting subtest: scaling-mode-full
[234.330672] Starting dynamic subtest: pipe-A-eDP-1
[234.419686] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[234.429342] Starting dynamic subtest: pipe-B-eDP-1
[235.628618] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[235.638865] Starting dynamic subtest: pipe-C-eDP-1
[236.748214] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[236.757484] Starting dynamic subtest: pipe-D-eDP-1
[237.893358] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[237.895675] Subtest scaling-mode-full: SUCCESS (3.568s)
[239.080452] [048/133] (789s left) kms_psr (fbc-pr-basic)
[239.178654] Starting subtest: fbc-pr-basic
[239.182859] Subtest fbc-pr-basic: SKIP (0.000s)
[239.278534] [049/133] (789s left) gem_ringfill (basic-all)
[245.103765] Starting subtest: basic-all
[246.274711] Subtest basic-all: SUCCESS (1.171s)
[246.436941] [050/133] (782s left) gem_exec_whisper (basic-fds-forked-all)
[246.515485] Starting subtest: basic-fds-forked-all
[268.655379] Subtest basic-fds-forked-all: SUCCESS (22.140s)
[268.862955] [051/133] (760s left) api_intel_bb (full-batch)
[268.918112] Starting subtest: full-batch
[268.924436] Subtest full-batch: SUCCESS (0.009s)
[269.088516] [052/133] (760s left) kms_cursor_crc (cursor-sliding-256x85)
[269.330402] Starting subtest: cursor-sliding-256x85
[269.374370] Subtest cursor-sliding-256x85: SKIP (0.042s)
[269.591863] [053/133] (759s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[269.699862] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[269.701986] Starting dynamic subtest: pipe-A-eDP-1
[269.757936] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[269.766759] Starting dynamic subtest: pipe-B-eDP-1
[269.814950] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[269.824641] Starting dynamic subtest: pipe-C-eDP-1
[269.872838] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[269.882146] Starting dynamic subtest: pipe-D-eDP-1
[269.931501] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[269.935739] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[272.040289] [054/133] (757s left) gen9_exec_parse (allowed-single)
[272.105341] Subtest allowed-single: SKIP (0.000s)
[272.185410] [055/133] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[272.285202] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[279.294717] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.014s)
[279.455176] [056/133] (749s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[279.558556] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[279.562970] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[279.678975] [057/133] (749s left) gem_exec_fence (expired-history)
[280.198580] Starting subtest: expired-history
[287.880091] Subtest expired-history: SUCCESS (7.684s)
[288.468623] [058/133] (740s left) kms_psr (fbc-psr-sprite-plane-move)
[288.570372] Starting subtest: fbc-psr-sprite-plane-move
[288.572555] Starting dynamic subtest: eDP-1
[288.576942] Dynamic subtest eDP-1: SKIP (0.000s)
[288.581275] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[288.666048] [059/133] (740s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[288.774882] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[295.559164] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.788s)
[295.718771] [060/133] (733s left) gem_ctx_bad_destroy (double-destroy)
[295.772171] Starting subtest: double-destroy
[295.774515] Subtest double-destroy: SUCCESS (0.000s)
[295.874609] [061/133] (733s left) syncobj_timeline (invalid-signal-illegal-handle)
[295.931969] Starting subtest: invalid-signal-illegal-handle
[295.933846] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[296.059603] [062/133] (733s left) kms_chamelium_hpd (common-hpd-after-suspend)
[296.439314] Subtest common-hpd-after-suspend: SKIP (0.000s)
[297.285248] [063/133] (732s left) kms_frontbuffer_tracking (fbc-tiling-4)
[297.385259] Starting subtest: fbc-tiling-4
[301.603467] Subtest fbc-tiling-4: SUCCESS (4.223s)
[302.836351] [064/133] (726s left) gem_cs_tlb (engines)
[302.893079] Starting subtest: engines
[302.895354] Starting dynamic subtest: rcs0
[305.047570] Dynamic subtest rcs0: SUCCESS (2.151s)
[305.056985] Starting dynamic subtest: bcs0
[307.198248] Dynamic subtest bcs0: SUCCESS (2.151s)
[307.210096] Starting dynamic subtest: vcs0
[309.350716] Dynamic subtest vcs0: SUCCESS (2.153s)
[309.360118] Starting dynamic subtest: vcs1
[311.503143] Dynamic subtest vcs1: SUCCESS (2.151s)
[311.515177] Starting dynamic subtest: vecs0
[313.657357] Dynamic subtest vecs0: SUCCESS (2.153s)
[313.668101] Starting dynamic subtest: ccs0
[315.810977] Dynamic subtest ccs0: SUCCESS (2.153s)
[315.813431] Subtest engines: SUCCESS (12.918s)
[315.960608] [065/133] (713s left) gem_mmap_gtt (hang-busy)
[316.020718] Subtest hang-busy: SKIP (0.000s)
[316.089804] [066/133] (713s left) kms_psr (psr2-sprite-plane-onoff)
[316.185597] Starting subtest: psr2-sprite-plane-onoff
[316.187727] Starting dynamic subtest: eDP-1
[317.917871] Dynamic subtest eDP-1: SUCCESS (1.732s)
[317.920136] Subtest psr2-sprite-plane-onoff: SUCCESS (1.733s)
[318.790762] [067/133] (711s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[318.894092] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[319.517844] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s)
[319.746469] [068/133] (710s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[319.845867] Starting subtest: y-tiled-64bpp-rotate-270
[319.850511] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[319.989376] [069/133] (709s left) gem_bad_reloc (negative-reloc-lut)
[320.061211] Subtest negative-reloc-lut: SKIP (0.000s)
[320.147933] [070/133] (709s left) gem_ctx_persistence (engines-mixed)
[320.210070] Starting subtest: engines-mixed
[320.212492] Starting dynamic subtest: rcs0
[320.334323] Dynamic subtest rcs0: SUCCESS (0.124s)
[320.346102] Starting dynamic subtest: bcs0
[320.416409] Dynamic subtest bcs0: SUCCESS (0.080s)
[320.427572] Starting dynamic subtest: vcs0
[320.490223] Dynamic subtest vcs0: SUCCESS (0.072s)
[320.501379] Starting dynamic subtest: vcs1
[320.565490] Dynamic subtest vcs1: SUCCESS (0.073s)
[320.576930] Starting dynamic subtest: vecs0
[320.639447] Dynamic subtest vecs0: SUCCESS (0.072s)
[320.650803] Starting dynamic subtest: ccs0
[320.712593] Dynamic subtest ccs0: SUCCESS (0.071s)
[320.714823] Subtest engines-mixed: SUCCESS (0.504s)
[320.816844] [071/133] (709s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[320.911905] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[320.913840] Starting dynamic subtest: pipe-A
[320.975714] Dynamic subtest pipe-A: SUCCESS (0.065s)
[320.984637] Starting dynamic subtest: pipe-B
[322.080652] Dynamic subtest pipe-B: SUCCESS (1.104s)
[322.092466] Starting dynamic subtest: pipe-C
[323.209292] Dynamic subtest pipe-C: SUCCESS (1.127s)
[323.219316] Starting dynamic subtest: pipe-D
[324.325984] Dynamic subtest pipe-D: SUCCESS (1.116s)
[324.328350] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.418s)
[325.511089] [072/133] (704s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[325.622708] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[325.626901] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[325.763018] [073/133] (704s left) gem_exec_schedule (semaphore-noskip)
[325.863737] Starting subtest: semaphore-noskip
[326.291859] Subtest semaphore-noskip: SUCCESS (0.427s)
[326.670082] [074/133] (703s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[326.766535] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[326.770666] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[326.911921] [075/133] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[327.012529] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[327.016604] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[327.136806] [076/133] (703s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[327.236833] Starting subtest: 4-tiled-16bpp-rotate-0
[328.524864] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.289s)
[328.704518] [077/133] (701s left) gem_exec_basic (basic)
[328.776149] Starting subtest: basic
[328.778356] Starting dynamic subtest: rcs0-smem
[328.780253] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[328.792190] Starting dynamic subtest: bcs0-smem
[328.793883] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[328.806730] Starting dynamic subtest: vcs0-smem
[328.808481] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[328.819081] Starting dynamic subtest: vcs1-smem
[328.820677] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[328.829951] Starting dynamic subtest: vecs0-smem
[328.831532] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[328.839624] Starting dynamic subtest: ccs0-smem
[328.841218] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[328.842771] Subtest basic: SUCCESS (0.015s)
[330.156020] [078/133] (700s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[330.273473] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[330.277469] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[330.413257] [079/133] (699s left) gem_mmap (short-mmap)
[330.481777] Subtest short-mmap: SKIP (0.000s)
[330.554075] [080/133] (699s left) gem_exec_reloc (basic-gtt-wc-active)
[330.620725] Subtest basic-gtt-wc-active: SKIP (0.000s)
[330.714249] [081/133] (699s left) gem_ctx_shared (create-shared-gtt)
[330.783372] Starting subtest: create-shared-gtt
[332.937428] Subtest create-shared-gtt: SUCCESS (2.153s)
[333.355940] [082/133] (697s left) gem_exec_reloc (basic-write-wc)
[333.428481] Subtest basic-write-wc: SKIP (0.000s)
[333.520385] [083/133] (696s left) gem_eio (wait-immediate)
[333.771886] Starting subtest: wait-immediate
[334.192656] Subtest wait-immediate: SUCCESS (0.420s)
[334.390269] [084/133] (696s left) gem_ctx_persistence (legacy-engines-mixed)
[334.443241] Starting subtest: legacy-engines-mixed
[334.445170] Starting dynamic subtest: render
[334.527075] Dynamic subtest render: SUCCESS (0.083s)
[334.542133] Starting dynamic subtest: bsd1
[334.611299] Dynamic subtest bsd1: SUCCESS (0.081s)
[334.625900] Starting dynamic subtest: bsd2
[334.692306] Dynamic subtest bsd2: SUCCESS (0.078s)
[334.706874] Starting dynamic subtest: blt
[334.800103] Dynamic subtest blt: SUCCESS (0.105s)
[334.814200] Starting dynamic subtest: vebox
[334.885435] Dynamic subtest vebox: SUCCESS (0.082s)
[334.887815] Subtest legacy-engines-mixed: SUCCESS (0.443s)
[334.989793] [085/133] (695s left) perf_pmu (semaphore-busy)
[335.034341] Starting subtest: semaphore-busy
[335.036113] Starting dynamic subtest: rcs0
[336.697258] Dynamic subtest rcs0: SUCCESS (1.660s)
[336.707804] Starting dynamic subtest: bcs0
[338.330682] Dynamic subtest bcs0: SUCCESS (1.631s)
[338.342608] Starting dynamic subtest: vcs0
[342.630419] Dynamic subtest vcs0: SUCCESS (4.297s)
[342.642665] Starting dynamic subtest: vcs1
[348.582237] Dynamic subtest vcs1: SUCCESS (5.946s)
[348.594414] Starting dynamic subtest: vecs0
[354.599253] Dynamic subtest vecs0: SUCCESS (6.012s)
[354.611639] Starting dynamic subtest: ccs0
[357.675026] Dynamic subtest ccs0: SUCCESS (3.072s)
[357.677660] Subtest semaphore-busy: SUCCESS (22.634s)
[357.815679] [086/133] (672s left) gem_exec_schedule (pi-common)
[358.011820] Starting subtest: pi-common
[358.014324] Starting dynamic subtest: rcs0
[358.049406] Dynamic subtest rcs0: SUCCESS (0.042s)
[358.059707] Starting dynamic subtest: bcs0
[358.094635] Dynamic subtest bcs0: SUCCESS (0.044s)
[358.104862] Starting dynamic subtest: vcs0
[358.134017] Dynamic subtest vcs0: SUCCESS (0.038s)
[358.144253] Starting dynamic subtest: vcs1
[358.169189] Dynamic subtest vcs1: SUCCESS (0.034s)
[358.179500] Starting dynamic subtest: vecs0
[358.203855] Dynamic subtest vecs0: SUCCESS (0.033s)
[358.214226] Starting dynamic subtest: ccs0
[358.237956] Dynamic subtest ccs0: SUCCESS (0.033s)
[358.240252] Subtest pi-common: SUCCESS (0.231s)
[358.492831] [087/133] (672s left) i915_hangman (engine-error-state-capture)
[358.561700] Starting subtest: engine-error-state-capture
[358.564009] Starting dynamic subtest: rcs0
[362.058626] Dynamic subtest rcs0: SUCCESS (3.494s)
[362.074136] Starting dynamic subtest: bcs0
[368.074750] Dynamic subtest bcs0: SUCCESS (6.011s)
[368.088319] Starting dynamic subtest: vcs0
[374.028744] Dynamic subtest vcs0: SUCCESS (5.950s)
[374.041531] Starting dynamic subtest: vcs1
[380.043375] Dynamic subtest vcs1: SUCCESS (6.010s)
[380.056360] Starting dynamic subtest: vecs0
[386.059226] Dynamic subtest vecs0: SUCCESS (6.012s)
[386.072716] Starting dynamic subtest: ccs0
[392.075119] Dynamic subtest ccs0: SUCCESS (6.013s)
[392.077826] Subtest engine-error-state-capture: SUCCESS (33.506s)
[392.184986] [088/133] (638s left) syncobj_timeline (wait-for-submit-snapshot)
[392.249413] Starting subtest: wait-for-submit-snapshot
[392.330565] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[392.439326] [089/133] (638s left) kms_color (ctm-blue-to-red)
[392.536641] Starting subtest: ctm-blue-to-red
[392.538830] Starting dynamic subtest: pipe-A-eDP-1
[393.235684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[393.246849] Starting dynamic subtest: pipe-B-eDP-1
[394.672232] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.436s)
[394.683410] Starting dynamic subtest: pipe-C-eDP-1
[396.042178] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[396.053379] Starting dynamic subtest: pipe-D-eDP-1
[397.403875] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.360s)
[397.406043] Subtest ctm-blue-to-red: SUCCESS (4.867s)
[398.234383] [090/133] (632s left) prime_vgem (basic-gtt)
[398.330247] Starting subtest: basic-gtt
[398.334930] Subtest basic-gtt: SKIP (0.000s)
[398.491783] [091/133] (632s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[398.597558] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[406.150127] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.554s)
[406.354656] [092/133] (624s left) api_intel_allocator (default-alignment)
[406.421783] Starting subtest: default-alignment
[406.424095] Subtest default-alignment: SUCCESS (0.003s)
[406.588542] [093/133] (624s left) i915_pm_rps (fence-order)
[406.644833] Starting subtest: fence-order
[410.154705] Subtest fence-order: SUCCESS (3.509s)
[410.323904] [094/133] (620s left) kms_vblank (query-busy)
[410.436904] Starting subtest: query-busy
[410.438853] Starting dynamic subtest: pipe-A-eDP-1
[412.327484] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.889s)
[412.343350] Starting dynamic subtest: pipe-D-eDP-1
[414.915253] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.585s)
[414.917174] Subtest query-busy: SUCCESS (4.478s)
[415.738961] [095/133] (615s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[415.855864] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[415.860058] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[415.982243] [096/133] (615s left) kms_addfb_basic (invalid-get-prop-any)
[416.041363] Starting subtest: invalid-get-prop-any
[416.043334] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[416.196573] [097/133] (614s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[416.293090] Starting subtest: fbc-psr2-cursor-mmap-gtt
[416.295352] Starting dynamic subtest: eDP-1
[416.299626] Dynamic subtest eDP-1: SKIP (0.000s)
[416.304006] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[416.394982] [098/133] (614s left) kms_flip (2x-blocking-absolute-wf_vblank)
[416.500816] Starting subtest: 2x-blocking-absolute-wf_vblank
[416.509338] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[416.611896] [099/133] (614s left) kms_cursor_crc (cursor-onscreen-256x85)
[416.881243] Starting subtest: cursor-onscreen-256x85
[416.930254] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[417.145116] [100/133] (614s left) kms_flip (2x-modeset-vs-vblank-race)
[417.245395] Starting subtest: 2x-modeset-vs-vblank-race
[417.255827] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[417.360081] [101/133] (613s left) kms_atomic_interruptible (atomic-setmode)
[417.453973] Starting subtest: atomic-setmode
[417.456004] Starting dynamic subtest: pipe-A-eDP-1
[424.367550] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.910s)
[424.369817] Subtest atomic-setmode: SUCCESS (6.911s)
[425.253379] [102/133] (606s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[425.358286] Starting subtest: psr-argb161616f-draw-render
[425.362443] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[425.494353] [103/133] (605s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[425.597387] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[425.601472] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[425.743982] [104/133] (605s left) kms_plane_scaling (invalid-num-scalers)
[425.836896] Starting subtest: invalid-num-scalers
[425.839156] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[425.862118] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.021s)
[425.872298] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[425.899058] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.035s)
[425.908916] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[425.935807] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.035s)
[425.947914] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[425.975009] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.038s)
[425.977238] Subtest invalid-num-scalers: SUCCESS (0.139s)
[426.110418] [105/133] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[426.207116] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[426.210707] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[426.342726] [106/133] (605s left) sw_sync (alloc_fence_invalid_timeline)
[426.375636] Starting subtest: alloc_fence_invalid_timeline
[426.377592] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[426.450143] [107/133] (605s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[426.504247] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[426.609044] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[426.710199] [108/133] (604s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[426.816814] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[426.819101] Starting dynamic subtest: A-eDP1
[435.769531] Dynamic subtest A-eDP1: SUCCESS (8.952s)
[435.783189] Starting dynamic subtest: B-eDP1
[444.703654] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[444.719139] Starting dynamic subtest: C-eDP1
[453.629143] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[453.639810] Starting dynamic subtest: D-eDP1
[462.554204] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[462.559169] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.745s)
[463.814570] [109/133] (567s left) kms_addfb_basic (size-max)
[463.912894] Starting subtest: size-max
[463.914876] Subtest size-max: SUCCESS (0.000s)
[464.035219] [110/133] (567s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[464.303685] Starting subtest: cursor-rapid-movement-256x256
[464.309563] Starting dynamic subtest: pipe-A-eDP-1
[464.849354] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[464.881626] Starting dynamic subtest: pipe-D-eDP-1
[466.099534] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[466.101997] Subtest cursor-rapid-movement-256x256: SUCCESS (1.796s)
[466.972600] [111/133] (564s left) gem_exec_whisper (basic-queues-all)
[467.051346] Starting subtest: basic-queues-all
[475.577418] Subtest basic-queues-all: SUCCESS (8.526s)
[475.788205] [112/133] (555s left) kms_dsc (dsc-fractional-bpp)
[475.888709] Starting subtest: dsc-fractional-bpp
[475.901431] Subtest dsc-fractional-bpp: SKIP (0.001s)
[475.987697] [113/133] (555s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[476.080918] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[476.083154] Starting dynamic subtest: pipe-A-default-mode
[476.376137] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[476.381042] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.293s)
[477.200687] [114/133] (554s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[477.307677] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[477.311747] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[477.423453] [115/133] (554s left) gem_softpin (evict-prime)
[477.480727] Starting subtest: evict-prime
[477.482926] Starting dynamic subtest: rcs0
[478.680924] Dynamic subtest rcs0: SUCCESS (1.199s)
[478.692018] Starting dynamic subtest: bcs0
[479.844578] Dynamic subtest bcs0: SUCCESS (1.161s)
[479.857699] Starting dynamic subtest: vcs0
[481.095365] Dynamic subtest vcs0: SUCCESS (1.247s)
[481.108095] Starting dynamic subtest: vcs1
[483.088422] Dynamic subtest vcs1: SUCCESS (1.990s)
[483.099238] Starting dynamic subtest: vecs0
[485.067579] Dynamic subtest vecs0: SUCCESS (1.977s)
[485.078682] Starting dynamic subtest: ccs0
[486.205095] Dynamic subtest ccs0: SUCCESS (1.136s)
[486.218535] Starting dynamic subtest: all
[488.067323] Dynamic subtest all: SUCCESS (1.859s)
[488.070108] Subtest evict-prime: SUCCESS (10.587s)
[488.174291] [116/133] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[488.284095] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[488.287979] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[488.418154] [117/133] (543s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[488.522009] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[488.661218] [118/133] (543s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[488.718813] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[488.825151] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[488.928258] [119/133] (543s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[489.030874] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[489.034921] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[489.165792] [120/133] (542s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[489.269492] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[493.396247] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.131s)
[494.600865] [121/133] (537s left) gem_mmap_wc (bad-size)
[494.674449] Subtest bad-size: SKIP (0.000s)
[494.743568] [122/133] (537s left) kms_hdr (static-toggle-suspend)
[494.832782] Starting subtest: static-toggle-suspend
[494.839180] Subtest static-toggle-suspend: SKIP (0.000s)
[494.927873] [123/133] (537s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[495.018244] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[495.022402] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[495.159493] [124/133] (537s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[500.253897] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[500.256265] Starting dynamic subtest: pipe-A-eDP-1
[501.032008] Dynamic subtest pipe-A-eDP-1: SKIP (0.775s)
[501.045463] Starting dynamic subtest: pipe-B-eDP-1
[502.158021] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[502.162609] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.904s)
[503.373518] [125/133] (528s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[503.481562] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[503.486215] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[503.625928] [126/133] (528s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[503.723955] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[503.726151] Starting dynamic subtest: pipe-A-eDP-1
[503.746605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[503.758780] Starting dynamic subtest: pipe-B-eDP-1
[503.777751] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[503.787839] Starting dynamic subtest: pipe-C-eDP-1
[503.807154] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[503.817197] Starting dynamic subtest: pipe-D-eDP-1
[503.837943] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[503.839956] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[505.962206] [127/133] (526s left) syncobj_timeline (single-wait-all-available-submitted)
[506.015902] Starting subtest: single-wait-all-available-submitted
[506.018237] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[506.140879] [128/133] (526s left) gem_exec_parallel (userptr)
[506.193834] Starting subtest: userptr
[506.196159] Starting dynamic subtest: rcs0
[507.671215] Dynamic subtest rcs0: SUCCESS (1.477s)
[507.682702] Starting dynamic subtest: bcs0
[509.138921] Dynamic subtest bcs0: SUCCESS (1.466s)
[509.153374] Starting dynamic subtest: vcs0
[511.082970] Dynamic subtest vcs0: SUCCESS (1.941s)
[511.093448] Starting dynamic subtest: vcs1
[513.068241] Dynamic subtest vcs1: SUCCESS (1.983s)
[513.081342] Starting dynamic subtest: vecs0
[515.116261] Dynamic subtest vecs0: SUCCESS (2.046s)
[515.129023] Starting dynamic subtest: ccs0
[516.615618] Dynamic subtest ccs0: SUCCESS (1.499s)
[516.617975] Subtest userptr: SUCCESS (10.425s)
[516.832843] [129/133] (515s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[516.943381] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[516.947813] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[517.117079] [130/133] (515s left) i915_selftest (mock)
[519.158352] Starting subtest: mock
[519.160699] Starting dynamic subtest: sanitycheck
[519.905000] Dynamic subtest sanitycheck: SUCCESS (0.747s)
[519.915142] Starting dynamic subtest: shmem
[520.679956] Dynamic subtest shmem: SUCCESS (0.772s)
[520.696436] Starting dynamic subtest: fence
[528.265869] Dynamic subtest fence: SUCCESS (7.584s)
[528.276036] Starting dynamic subtest: scatterlist
[530.009651] Dynamic subtest scatterlist: SUCCESS (1.742s)
[530.019205] Starting dynamic subtest: syncmap
[533.464411] Dynamic subtest syncmap: SUCCESS (3.453s)
[533.474559] Starting dynamic subtest: uncore
[534.202919] Dynamic subtest uncore: SUCCESS (0.737s)
[534.212331] Starting dynamic subtest: ring
[534.924214] Dynamic subtest ring: SUCCESS (0.719s)
[534.934641] Starting dynamic subtest: engine
[535.676843] Dynamic subtest engine: SUCCESS (0.751s)
[535.687039] Starting dynamic subtest: timelines
[539.681774] Dynamic subtest timelines: SUCCESS (4.003s)
[539.691596] Starting dynamic subtest: requests
[543.000003] Dynamic subtest requests: SUCCESS (3.317s)
[543.010005] Starting dynamic subtest: objects
[543.864997] Dynamic subtest objects: SUCCESS (0.864s)
[543.875046] Starting dynamic subtest: phys
[544.746885] Dynamic subtest phys: SUCCESS (0.880s)
[544.756845] Starting dynamic subtest: dmabuf
[545.557570] Dynamic subtest dmabuf: SUCCESS (0.810s)
[545.567629] Starting dynamic subtest: vma
[551.050524] Dynamic subtest vma: SUCCESS (5.491s)
[551.060454] Starting dynamic subtest: evict
[552.558012] Dynamic subtest evict: SUCCESS (1.505s)
[552.568027] Starting dynamic subtest: gtt
[555.916111] Dynamic subtest gtt: SUCCESS (3.356s)
[555.926079] Starting dynamic subtest: hugepages
[556.927201] Dynamic subtest hugepages: SUCCESS (1.009s)
[556.937384] Starting dynamic subtest: memory_region
[559.619903] Dynamic subtest memory_region: SUCCESS (2.691s)
[559.622733] Subtest mock: SUCCESS (40.470s)
[559.652638] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[559.653332] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[559.656333] [131/133] (472s left) gem_mmap_gtt (basic-write-read)
[561.162937] Subtest basic-write-read: SKIP (0.000s)
[561.252823] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[561.254104] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[561.257882] [132/133] (471s left) perf (gen12-group-exclusive-stream-sample-oa)
[561.410256] Starting subtest: gen12-group-exclusive-stream-sample-oa
[561.430593] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s)
[561.475644] [133/133] (471s left) perf_pmu (busy-double-start)
[561.513831] Starting subtest: busy-double-start
[561.516260] Starting dynamic subtest: rcs0
[565.159026] Dynamic subtest rcs0: FAIL (3.587s)
[565.169678] Starting dynamic subtest: bcs0
[568.679486] Dynamic subtest bcs0: SUCCESS (3.579s)
[568.689691] Starting dynamic subtest: vcs0
[572.593544] Dynamic subtest vcs0: SUCCESS (3.912s)
[572.604874] Starting dynamic subtest: vcs1
[576.666724] Dynamic subtest vcs1: SUCCESS (4.071s)
[576.678641] Starting dynamic subtest: vecs0
[580.644451] Dynamic subtest vecs0: SUCCESS (3.976s)
[580.656293] Starting dynamic subtest: ccs0
[584.311428] Dynamic subtest ccs0: FAIL (3.562s)
[584.313455] Subtest busy-double-start: FAIL (22.699s)
[584.363734] 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.