[56.648209] Initializing watchdogs
[56.648253]   /dev/watchdog0
[56.661258] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.665425] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.667543] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.670813] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[56.766740] Subtest write-snoop: SKIP (0.000s)
[56.854919] [002/133] (960s left) kms_content_protection (content-type-change)
[57.008924] Starting subtest: content-type-change
[57.012951] Subtest content-type-change: SKIP (0.000s)
[57.164794] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[57.249631] Starting subtest: multiplane-rotation
[74.618622] Subtest multiplane-rotation: SUCCESS (17.449s)
[74.774776] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[74.868648] Subtest ctm-red-to-blue: SKIP (0.000s)
[74.909091] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[74.976061] Starting subtest: invalid-reset-one-illegal-handle
[74.977907] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[75.089648] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[75.172081] Starting subtest: disable-crc-after-crtc
[75.173941] Starting dynamic subtest: pipe-A-eDP-1
[76.844307] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.671s)
[76.853146] Starting dynamic subtest: pipe-B-eDP-1
[79.109637] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.267s)
[79.117966] Starting dynamic subtest: pipe-C-eDP-1
[81.377304] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.266s)
[81.384545] Starting dynamic subtest: pipe-D-eDP-1
[83.628752] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.249s)
[83.631124] Subtest disable-crc-after-crtc: SUCCESS (8.459s)
[84.481486] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[84.551946] Subtest tiled-to-tiled: SKIP (0.000s)
[84.629526] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[84.692285] Starting subtest: wait-all-interrupted
[84.793196] Subtest wait-all-interrupted: SUCCESS (0.101s)
[84.886073] [009/133] (932s left) syncobj_wait (wait-all-complex)
[84.940220] Starting subtest: wait-all-complex
[85.152800] Subtest wait-all-complex: SUCCESS (0.212s)
[85.252012] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[85.390069] Starting subtest: reject-modify-context-protection-on
[85.392405] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[85.520832] [011/133] (932s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[85.635768] Starting subtest: cursorA-vs-flipB-varying-size
[85.640271] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[85.799714] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[85.897122] Starting subtest: primary-rotation-90
[85.901172] Subtest primary-rotation-90: SKIP (0.001s)
[85.992267] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[86.048917] Starting subtest: reset-multiple-signaled
[86.051272] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[86.162926] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[86.252188] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[86.255832] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[87.425065] [015/133] (930s left) gem_softpin (noreloc-s3)
[87.508101] Starting subtest: noreloc-S3
[107.215458] Subtest noreloc-S3: SUCCESS (5.387s)
[107.376545] [016/133] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[107.495047] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[111.867853] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.482s)
[113.029102] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[113.092157] Starting subtest: invalid-ctx-set
[113.094559] Subtest invalid-ctx-set: SUCCESS (0.001s)
[113.230406] [018/133] (904s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[113.288431] Starting subtest: single-wait-all-for-submit-unsubmitted
[113.391058] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[113.486192] [019/133] (904s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[113.591055] Starting subtest: x-tiled-64bpp-rotate-90
[113.610440] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[113.750416] [020/133] (904s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[113.816699] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[113.870704] [021/133] (904s left) kms_psr (fbc-psr-cursor-plane-move)
[113.960067] Starting subtest: fbc-psr-cursor-plane-move
[113.962237] Starting dynamic subtest: eDP-1
[113.966544] Dynamic subtest eDP-1: SKIP (0.000s)
[113.970886] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[114.054140] [022/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[114.156383] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[115.133880] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.989s)
[115.300542] [023/133] (902s left) kms_flip (2x-flip-vs-rmfb)
[115.401441] Starting subtest: 2x-flip-vs-rmfb
[115.412132] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[115.540219] [024/133] (902s left) kms_plane_cursor (viewport)
[115.640477] Starting subtest: viewport
[115.644089] Starting dynamic subtest: pipe-A-eDP-1-size-64
[118.113304] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.495s)
[118.171353] Starting dynamic subtest: pipe-A-eDP-1-size-128
[120.752259] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.604s)
[120.811307] Starting dynamic subtest: pipe-A-eDP-1-size-256
[123.396229] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.605s)
[123.760262] Starting dynamic subtest: pipe-B-eDP-1-size-64
[127.056358] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.316s)
[127.115675] Starting dynamic subtest: pipe-B-eDP-1-size-128
[129.551361] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.449s)
[129.609801] Starting dynamic subtest: pipe-B-eDP-1-size-256
[132.037266] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.437s)
[132.383572] Starting dynamic subtest: pipe-C-eDP-1-size-64
[135.243829] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.872s)
[135.279813] Starting dynamic subtest: pipe-C-eDP-1-size-128
[137.411751] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.135s)
[137.453630] Starting dynamic subtest: pipe-C-eDP-1-size-256
[139.626123] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.179s)
[139.967324] Starting dynamic subtest: pipe-D-eDP-1-size-64
[142.853907] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.893s)
[142.890144] Starting dynamic subtest: pipe-D-eDP-1-size-128
[144.986991] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.102s)
[145.024064] Starting dynamic subtest: pipe-D-eDP-1-size-256
[147.121798] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.102s)
[147.447611] Subtest viewport: SUCCESS (31.882s)
[148.258867] [025/133] (869s left) kms_cdclk (mode-transition)
[148.360021] Starting subtest: mode-transition
[148.362323] Starting dynamic subtest: pipe-A-eDP-1
[148.650780] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[148.659748] Starting dynamic subtest: pipe-B-eDP-1
[148.664378] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[148.672905] Starting dynamic subtest: pipe-C-eDP-1
[148.678127] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[148.691425] Starting dynamic subtest: pipe-D-eDP-1
[148.695882] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[148.700027] Subtest mode-transition: SKIP (0.295s)
[149.494283] [026/133] (868s left) gem_exec_balancer (fairslice)
[149.554015] Starting subtest: fairslice
[152.397813] Subtest fairslice: SUCCESS (2.842s)
[153.377596] [027/133] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[153.511928] Starting subtest: basic-flip-before-cursor-varying-size
[154.426884] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.917s)
[155.335959] [028/133] (862s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[155.430379] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[155.432782] Starting dynamic subtest: pipe-A-default-mode
[155.720003] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[155.724749] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.287s)
[156.565460] [029/133] (861s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[156.656359] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[156.658735] Starting dynamic subtest: pipe-A-default-mode
[159.396916] Dynamic subtest pipe-A-default-mode: SUCCESS (2.741s)
[159.399334] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.743s)
[160.262075] [030/133] (857s left) core_getstats (basic)
[160.317587] Starting subtest: basic
[160.319847] Subtest basic: SUCCESS (0.000s)
[160.443033] [031/133] (857s left) kms_rmfb (close-fd)
[160.530641] Starting subtest: close-fd
[160.532580] Starting dynamic subtest: pipe-A-eDP-1
[160.638666] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[160.647838] Starting dynamic subtest: pipe-B-eDP-1
[161.807987] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[161.817429] Starting dynamic subtest: pipe-C-eDP-1
[162.927534] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[162.936468] Starting dynamic subtest: pipe-D-eDP-1
[164.053739] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[164.055712] Subtest close-fd: SUCCESS (3.524s)
[165.287125] [032/133] (853s left) gem_exec_reloc (basic-gtt-wc)
[165.358114] Subtest basic-gtt-wc: SKIP (0.000s)
[165.436501] [033/133] (852s left) kms_properties (crtc-properties-legacy)
[165.533082] Starting subtest: crtc-properties-legacy
[165.535230] Starting dynamic subtest: pipe-A-eDP-1
[165.962285] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.429s)
[165.970658] Starting dynamic subtest: pipe-B-eDP-1
[167.118710] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.156s)
[167.127354] Starting dynamic subtest: pipe-C-eDP-1
[168.230934] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[168.240778] Starting dynamic subtest: pipe-D-eDP-1
[169.379809] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[169.382146] Subtest crtc-properties-legacy: SUCCESS (3.848s)
[170.202453] [034/133] (848s left) kms_invalid_mode (zero-hdisplay)
[170.312166] Starting subtest: zero-hdisplay
[170.314467] Starting dynamic subtest: pipe-A-eDP-1
[170.596097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[170.605207] Starting dynamic subtest: pipe-B-eDP-1
[170.607210] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[170.615871] Starting dynamic subtest: pipe-C-eDP-1
[170.618165] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[170.625638] Starting dynamic subtest: pipe-D-eDP-1
[170.627861] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[170.630118] Subtest zero-hdisplay: SUCCESS (0.289s)
[171.429781] [035/133] (847s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[171.527493] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[171.529726] Starting dynamic subtest: pipe-A
[172.574967] Dynamic subtest pipe-A: SUCCESS (1.050s)
[172.585849] Starting dynamic subtest: pipe-B
[174.721094] Dynamic subtest pipe-B: SUCCESS (2.145s)
[174.728917] Starting dynamic subtest: pipe-C
[175.910840] Dynamic subtest pipe-C: SUCCESS (1.189s)
[175.921469] Starting dynamic subtest: pipe-D
[177.137907] Dynamic subtest pipe-D: SUCCESS (1.227s)
[177.140210] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.615s)
[178.350966] [036/133] (840s left) kms_pm_rpm (legacy-planes-dpms)
[180.485290] Starting subtest: legacy-planes-dpms
[180.487354] Starting dynamic subtest: plane-63
[189.098179] Dynamic subtest plane-63: SUCCESS (8.617s)
[189.108378] Starting dynamic subtest: plane-93
[197.799197] Dynamic subtest plane-93: SUCCESS (8.701s)
[197.811129] Starting dynamic subtest: plane-123
[206.084465] Dynamic subtest plane-123: SUCCESS (8.279s)
[206.095859] Starting dynamic subtest: plane-133
[214.671197] Dynamic subtest plane-133: SUCCESS (8.581s)
[214.674156] Subtest legacy-planes-dpms: SUCCESS (34.189s)
[215.062238] [037/133] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[215.161856] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[215.166297] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[215.302978] [038/133] (803s left) kms_dirtyfb (default-dirtyfb-ioctl)
[215.406313] Starting subtest: default-dirtyfb-ioctl
[215.408213] Starting dynamic subtest: A-eDP-1
[216.982888] Dynamic subtest A-eDP-1: SUCCESS (1.576s)
[216.985405] Subtest default-dirtyfb-ioctl: SUCCESS (1.578s)
[217.791383] [039/133] (800s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[217.918202] Starting subtest: cursorB-vs-flipA-legacy
[217.922442] Subtest cursorB-vs-flipA-legacy: SKIP (0.003s)
[218.082532] [040/133] (800s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[218.140425] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[218.142800] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[218.273624] [041/133] (800s left) kms_prime (basic-crc-vgem)
[218.414399] Starting subtest: basic-crc-vgem
[218.416443] Starting dynamic subtest: second-to-first
[219.353954] Dynamic subtest second-to-first: SUCCESS (0.941s)
[219.355998] Subtest basic-crc-vgem: SUCCESS (0.942s)
[219.468124] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[219.473233] [042/133] (799s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[219.573855] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[219.642889] [043/133] (799s left) i915_drm_fdinfo (busy)
[219.679776] Starting subtest: busy
[219.681718] Starting dynamic subtest: rcs0
[219.704834] Dynamic subtest rcs0: SKIP (0.023s)
[219.714776] Starting dynamic subtest: bcs0
[219.728876] Dynamic subtest bcs0: SKIP (0.023s)
[219.742210] Starting dynamic subtest: vcs0
[219.745828] Dynamic subtest vcs0: SKIP (0.001s)
[219.755696] Starting dynamic subtest: vcs1
[219.759340] Dynamic subtest vcs1: SKIP (0.000s)
[219.766691] Starting dynamic subtest: vecs0
[219.770138] Dynamic subtest vecs0: SKIP (0.000s)
[219.777487] Starting dynamic subtest: ccs0
[219.780901] Dynamic subtest ccs0: SKIP (0.000s)
[219.784262] Subtest busy: SKIP (0.055s)
[219.830322] [044/133] (798s left) gem_userptr_blits (nohangcheck)
[219.916268] Starting subtest: nohangcheck
[220.171596] Subtest nohangcheck: SUCCESS (0.252s)
[220.319631] [045/133] (798s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[220.426659] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[221.027892] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.603s)
[221.252793] [046/133] (797s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[221.347379] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[221.351876] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[222.518752] [047/133] (796s left) kms_scaling_modes (scaling-mode-full)
[222.618666] Starting subtest: scaling-mode-full
[222.621017] Starting dynamic subtest: pipe-A-eDP-1
[222.712842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[222.723861] Starting dynamic subtest: pipe-B-eDP-1
[223.926858] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s)
[223.939801] Starting dynamic subtest: pipe-C-eDP-1
[225.050735] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[225.059507] Starting dynamic subtest: pipe-D-eDP-1
[226.173457] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[226.175804] Subtest scaling-mode-full: SUCCESS (3.555s)
[227.366927] [048/133] (791s left) kms_psr (fbc-pr-basic)
[227.472569] Starting subtest: fbc-pr-basic
[227.476641] Subtest fbc-pr-basic: SKIP (0.000s)
[227.570522] [049/133] (791s left) gem_ringfill (basic-all)
[233.335648] Starting subtest: basic-all
[234.496225] Subtest basic-all: SUCCESS (1.160s)
[234.667432] [050/133] (784s left) gem_exec_whisper (basic-fds-forked-all)
[234.742779] Starting subtest: basic-fds-forked-all
[256.402279] Subtest basic-fds-forked-all: SUCCESS (21.655s)
[256.604844] [051/133] (762s left) api_intel_bb (full-batch)
[256.653643] Starting subtest: full-batch
[256.664191] Subtest full-batch: SUCCESS (0.012s)
[256.818146] [052/133] (762s left) kms_cursor_crc (cursor-sliding-256x85)
[257.052123] Starting subtest: cursor-sliding-256x85
[257.098954] Subtest cursor-sliding-256x85: SKIP (0.042s)
[257.304865] [053/133] (761s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[257.402496] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[257.404674] Starting dynamic subtest: pipe-A-eDP-1
[257.460564] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[257.469192] Starting dynamic subtest: pipe-B-eDP-1
[257.524664] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[257.533299] Starting dynamic subtest: pipe-C-eDP-1
[257.577668] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[257.586652] Starting dynamic subtest: pipe-D-eDP-1
[257.632859] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[257.636427] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[259.717621] [054/133] (759s left) gen9_exec_parse (allowed-single)
[259.772033] Subtest allowed-single: SKIP (0.000s)
[259.836067] [055/133] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[259.933452] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[266.838455] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.908s)
[266.989222] [056/133] (752s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[267.091691] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[267.095583] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[267.228292] [057/133] (752s left) gem_exec_fence (expired-history)
[267.750050] Starting subtest: expired-history
[275.120932] Subtest expired-history: SUCCESS (7.372s)
[275.718224] [058/133] (743s left) kms_psr (fbc-psr-sprite-plane-move)
[275.823276] Starting subtest: fbc-psr-sprite-plane-move
[275.825548] Starting dynamic subtest: eDP-1
[275.829686] Dynamic subtest eDP-1: SKIP (0.000s)
[275.833885] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[275.920749] [059/133] (743s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[276.022653] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[282.734203] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.723s)
[282.897988] [060/133] (736s left) gem_ctx_bad_destroy (double-destroy)
[282.962083] Starting subtest: double-destroy
[282.964075] Subtest double-destroy: SUCCESS (0.000s)
[283.057445] [061/133] (736s left) syncobj_timeline (invalid-signal-illegal-handle)
[283.104339] Starting subtest: invalid-signal-illegal-handle
[283.106256] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[283.229549] [062/133] (736s left) kms_chamelium_hpd (common-hpd-after-suspend)
[283.622654] Subtest common-hpd-after-suspend: SKIP (0.000s)
[284.423553] [063/133] (735s left) kms_frontbuffer_tracking (fbc-tiling-4)
[284.532014] Starting subtest: fbc-tiling-4
[288.742938] Subtest fbc-tiling-4: SUCCESS (4.215s)
[289.963872] [064/133] (729s left) gem_cs_tlb (engines)
[290.029679] Starting subtest: engines
[290.032001] Starting dynamic subtest: rcs0
[292.184586] Dynamic subtest rcs0: SUCCESS (2.153s)
[292.195295] Starting dynamic subtest: bcs0
[294.336077] Dynamic subtest bcs0: SUCCESS (2.151s)
[294.345622] Starting dynamic subtest: vcs0
[296.489984] Dynamic subtest vcs0: SUCCESS (2.152s)
[296.499514] Starting dynamic subtest: vcs1
[298.640770] Dynamic subtest vcs1: SUCCESS (2.151s)
[298.650238] Starting dynamic subtest: vecs0
[300.792711] Dynamic subtest vecs0: SUCCESS (2.152s)
[300.801692] Starting dynamic subtest: ccs0
[302.945707] Dynamic subtest ccs0: SUCCESS (2.152s)
[302.947579] Subtest engines: SUCCESS (12.916s)
[303.126075] [065/133] (716s left) gem_mmap_gtt (hang-busy)
[303.187252] Subtest hang-busy: SKIP (0.000s)
[303.256902] [066/133] (716s left) kms_psr (psr2-sprite-plane-onoff)
[303.345205] Starting subtest: psr2-sprite-plane-onoff
[303.347319] Starting dynamic subtest: eDP-1
[305.032448] Dynamic subtest eDP-1: SUCCESS (1.687s)
[305.034596] Subtest psr2-sprite-plane-onoff: SUCCESS (1.688s)
[305.923205] [067/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[306.036347] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[306.671317] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[306.902668] [068/133] (712s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[307.007654] Starting subtest: y-tiled-64bpp-rotate-270
[307.011714] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[307.125750] [069/133] (712s left) gem_bad_reloc (negative-reloc-lut)
[307.193779] Subtest negative-reloc-lut: SKIP (0.000s)
[307.264041] [070/133] (712s left) gem_ctx_persistence (engines-mixed)
[307.324510] Starting subtest: engines-mixed
[307.326892] Starting dynamic subtest: rcs0
[307.426934] Dynamic subtest rcs0: SUCCESS (0.102s)
[307.439836] Starting dynamic subtest: bcs0
[307.510212] Dynamic subtest bcs0: SUCCESS (0.081s)
[307.523465] Starting dynamic subtest: vcs0
[307.576992] Dynamic subtest vcs0: SUCCESS (0.065s)
[307.588690] Starting dynamic subtest: vcs1
[307.651277] Dynamic subtest vcs1: SUCCESS (0.072s)
[307.663176] Starting dynamic subtest: vecs0
[307.722893] Dynamic subtest vecs0: SUCCESS (0.070s)
[307.734626] Starting dynamic subtest: ccs0
[307.791071] Dynamic subtest ccs0: SUCCESS (0.066s)
[307.793677] Subtest engines-mixed: SUCCESS (0.468s)
[307.896332] [071/133] (712s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[307.994907] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[307.996904] Starting dynamic subtest: pipe-A
[308.060483] Dynamic subtest pipe-A: SUCCESS (0.067s)
[308.071687] Starting dynamic subtest: pipe-B
[309.214505] Dynamic subtest pipe-B: SUCCESS (1.151s)
[309.229268] Starting dynamic subtest: pipe-C
[310.322075] Dynamic subtest pipe-C: SUCCESS (1.105s)
[310.333611] Starting dynamic subtest: pipe-D
[311.453689] Dynamic subtest pipe-D: SUCCESS (1.131s)
[311.456041] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.462s)
[312.629982] [072/133] (707s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[312.731300] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[312.735478] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[312.878539] [073/133] (707s left) gem_exec_schedule (semaphore-noskip)
[312.957862] Starting subtest: semaphore-noskip
[313.374160] Subtest semaphore-noskip: SUCCESS (0.423s)
[313.738837] [074/133] (706s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[313.840825] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[313.844842] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[313.981275] [075/133] (706s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[314.085888] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[314.089944] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[314.220254] [076/133] (705s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[314.326155] Starting subtest: 4-tiled-16bpp-rotate-0
[315.628227] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.302s)
[315.784770] [077/133] (704s left) gem_exec_basic (basic)
[315.845457] Starting subtest: basic
[315.849367] Starting dynamic subtest: rcs0-smem
[315.853161] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[315.862376] Starting dynamic subtest: bcs0-smem
[315.864165] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[315.872921] Starting dynamic subtest: vcs0-smem
[315.874704] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[315.882982] Starting dynamic subtest: vcs1-smem
[315.884819] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[315.893058] Starting dynamic subtest: vecs0-smem
[315.894850] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[315.903164] Starting dynamic subtest: ccs0-smem
[315.905038] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[315.906832] Subtest basic: SUCCESS (0.014s)
[317.362234] [078/133] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[317.460932] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[317.465100] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[317.578336] [079/133] (702s left) gem_mmap (short-mmap)
[317.638427] Subtest short-mmap: SKIP (0.000s)
[317.701488] [080/133] (702s left) gem_exec_reloc (basic-gtt-wc-active)
[317.759545] Subtest basic-gtt-wc-active: SKIP (0.000s)
[317.820545] [081/133] (702s left) gem_ctx_shared (create-shared-gtt)
[317.874660] Starting subtest: create-shared-gtt
[320.027452] Subtest create-shared-gtt: SUCCESS (2.153s)
[320.429293] [082/133] (699s left) gem_exec_reloc (basic-write-wc)
[320.498896] Subtest basic-write-wc: SKIP (0.000s)
[320.588055] [083/133] (699s left) gem_eio (wait-immediate)
[320.835731] Starting subtest: wait-immediate
[321.288666] Subtest wait-immediate: SUCCESS (0.452s)
[321.428051] [084/133] (699s left) gem_ctx_persistence (legacy-engines-mixed)
[321.492982] Starting subtest: legacy-engines-mixed
[321.495370] Starting dynamic subtest: render
[321.588373] Dynamic subtest render: SUCCESS (0.095s)
[321.600479] Starting dynamic subtest: bsd1
[321.663605] Dynamic subtest bsd1: SUCCESS (0.072s)
[321.676357] Starting dynamic subtest: bsd2
[321.742121] Dynamic subtest bsd2: SUCCESS (0.076s)
[321.753691] Starting dynamic subtest: blt
[321.822039] Dynamic subtest blt: SUCCESS (0.079s)
[321.837200] Starting dynamic subtest: vebox
[321.892421] Dynamic subtest vebox: SUCCESS (0.067s)
[321.895032] Subtest legacy-engines-mixed: SUCCESS (0.401s)
[321.998112] [085/133] (698s left) perf_pmu (semaphore-busy)
[322.042950] Starting subtest: semaphore-busy
[322.045034] Starting dynamic subtest: rcs0
[323.713435] Dynamic subtest rcs0: SUCCESS (1.666s)
[323.726235] Starting dynamic subtest: bcs0
[325.347912] Dynamic subtest bcs0: SUCCESS (1.632s)
[325.359308] Starting dynamic subtest: vcs0
[329.837109] Dynamic subtest vcs0: SUCCESS (4.486s)
[329.847424] Starting dynamic subtest: vcs1
[335.853470] Dynamic subtest vcs1: SUCCESS (6.012s)
[335.865601] Starting dynamic subtest: vecs0
[341.869616] Dynamic subtest vecs0: SUCCESS (6.011s)
[341.881908] Starting dynamic subtest: ccs0
[344.942367] Dynamic subtest ccs0: SUCCESS (3.069s)
[344.944832] Subtest semaphore-busy: SUCCESS (22.892s)
[345.080838] [086/133] (675s left) gem_exec_schedule (pi-common)
[345.283743] Starting subtest: pi-common
[345.286287] Starting dynamic subtest: rcs0
[345.321271] Dynamic subtest rcs0: SUCCESS (0.040s)
[345.335580] Starting dynamic subtest: bcs0
[345.367059] Dynamic subtest bcs0: SUCCESS (0.045s)
[345.377811] Starting dynamic subtest: vcs0
[345.405351] Dynamic subtest vcs0: SUCCESS (0.037s)
[345.414927] Starting dynamic subtest: vcs1
[345.442802] Dynamic subtest vcs1: SUCCESS (0.036s)
[345.452465] Starting dynamic subtest: vecs0
[345.477162] Dynamic subtest vecs0: SUCCESS (0.033s)
[345.486688] Starting dynamic subtest: ccs0
[345.510974] Dynamic subtest ccs0: SUCCESS (0.033s)
[345.513111] Subtest pi-common: SUCCESS (0.231s)
[345.775254] [087/133] (674s left) i915_hangman (engine-error-state-capture)
[345.857657] Starting subtest: engine-error-state-capture
[345.860063] Starting dynamic subtest: rcs0
[351.314055] Dynamic subtest rcs0: SUCCESS (5.453s)
[351.328120] Starting dynamic subtest: bcs0
[357.265905] Dynamic subtest bcs0: SUCCESS (5.948s)
[357.278974] Starting dynamic subtest: vcs0
[363.282720] Dynamic subtest vcs0: SUCCESS (6.013s)
[363.295337] Starting dynamic subtest: vcs1
[369.233683] Dynamic subtest vcs1: SUCCESS (5.948s)
[369.246305] Starting dynamic subtest: vecs0
[374.225725] Dynamic subtest vecs0: SUCCESS (4.988s)
[374.238116] Starting dynamic subtest: ccs0
[379.281770] Dynamic subtest ccs0: SUCCESS (5.052s)
[379.284821] Subtest engine-error-state-capture: SUCCESS (33.419s)
[379.393677] [088/133] (641s left) syncobj_timeline (wait-for-submit-snapshot)
[379.457646] Starting subtest: wait-for-submit-snapshot
[379.538730] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[379.641305] [089/133] (641s left) kms_color (ctm-blue-to-red)
[379.748585] Starting subtest: ctm-blue-to-red
[379.750775] Starting dynamic subtest: pipe-A-eDP-1
[380.435704] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[380.445766] Starting dynamic subtest: pipe-B-eDP-1
[381.758815] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.324s)
[381.769777] Starting dynamic subtest: pipe-C-eDP-1
[383.076349] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.314s)
[383.087547] Starting dynamic subtest: pipe-D-eDP-1
[384.433793] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.359s)
[384.436052] Subtest ctm-blue-to-red: SUCCESS (4.687s)
[385.252647] [090/133] (635s left) prime_vgem (basic-gtt)
[385.328213] Starting subtest: basic-gtt
[385.332912] Subtest basic-gtt: SKIP (0.000s)
[385.462819] [091/133] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[385.566083] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[393.064010] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.501s)
[393.249820] [092/133] (627s left) api_intel_allocator (default-alignment)
[393.313919] Starting subtest: default-alignment
[393.316403] Subtest default-alignment: SUCCESS (0.003s)
[393.474074] [093/133] (627s left) i915_pm_rps (fence-order)
[393.532753] Starting subtest: fence-order
[396.615174] Subtest fence-order: SUCCESS (3.080s)
[396.767913] [094/133] (624s left) kms_vblank (query-busy)
[396.869616] Starting subtest: query-busy
[396.871867] Starting dynamic subtest: pipe-A-eDP-1
[398.746705] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[398.767181] Starting dynamic subtest: pipe-D-eDP-1
[401.303364] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.554s)
[401.305611] Subtest query-busy: SUCCESS (4.434s)
[402.128732] [095/133] (618s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[402.228236] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[402.232661] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[402.358702] [096/133] (618s left) kms_addfb_basic (invalid-get-prop-any)
[402.412863] Starting subtest: invalid-get-prop-any
[402.415125] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[402.579072] [097/133] (618s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[402.672006] Starting subtest: fbc-psr2-cursor-mmap-gtt
[402.674413] Starting dynamic subtest: eDP-1
[402.678990] Dynamic subtest eDP-1: SKIP (0.000s)
[402.683686] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[402.806058] [098/133] (618s left) kms_flip (2x-blocking-absolute-wf_vblank)
[402.907633] Starting subtest: 2x-blocking-absolute-wf_vblank
[402.915883] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[403.062363] [099/133] (618s left) kms_cursor_crc (cursor-onscreen-256x85)
[403.311237] Starting subtest: cursor-onscreen-256x85
[403.358042] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[403.578429] [100/133] (617s left) kms_flip (2x-modeset-vs-vblank-race)
[403.675428] Starting subtest: 2x-modeset-vs-vblank-race
[403.686830] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[403.789979] [101/133] (617s left) kms_atomic_interruptible (atomic-setmode)
[403.889032] Starting subtest: atomic-setmode
[403.890926] Starting dynamic subtest: pipe-A-eDP-1
[410.773977] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.884s)
[410.776578] Subtest atomic-setmode: SUCCESS (6.885s)
[411.592523] [102/133] (609s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[411.693303] Starting subtest: psr-argb161616f-draw-render
[411.697550] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[411.805471] [103/133] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[411.913961] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[411.918040] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[412.034484] [104/133] (609s left) kms_plane_scaling (invalid-num-scalers)
[412.134263] Starting subtest: invalid-num-scalers
[412.136531] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[412.150625] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[412.165620] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[412.185724] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[412.200976] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[412.221976] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[412.232000] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[412.253034] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.030s)
[412.255308] Subtest invalid-num-scalers: SUCCESS (0.121s)
[412.387701] [105/133] (608s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[412.490894] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[412.495006] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[412.613690] [106/133] (608s left) sw_sync (alloc_fence_invalid_timeline)
[412.649897] Starting subtest: alloc_fence_invalid_timeline
[412.651785] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[412.725602] [107/133] (608s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[412.781730] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[412.887716] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[412.987918] [108/133] (608s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[413.076586] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[413.079006] Starting dynamic subtest: A-eDP1
[422.011324] Dynamic subtest A-eDP1: SUCCESS (8.935s)
[422.023128] Starting dynamic subtest: B-eDP1
[430.936875] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[430.951782] Starting dynamic subtest: C-eDP1
[439.860260] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[439.869976] Starting dynamic subtest: D-eDP1
[448.781864] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[448.787118] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.713s)
[450.021698] [109/133] (571s left) kms_addfb_basic (size-max)
[450.124602] Starting subtest: size-max
[450.126964] Subtest size-max: SUCCESS (0.000s)
[450.262201] [110/133] (571s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[450.511523] Starting subtest: cursor-rapid-movement-256x256
[450.513774] Starting dynamic subtest: pipe-A-eDP-1
[451.045249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[451.072511] Starting dynamic subtest: pipe-D-eDP-1
[452.327479] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.262s)
[452.329317] Subtest cursor-rapid-movement-256x256: SUCCESS (1.818s)
[453.208438] [111/133] (568s left) gem_exec_whisper (basic-queues-all)
[453.279996] Starting subtest: basic-queues-all
[463.315319] Subtest basic-queues-all: SUCCESS (10.033s)
[463.524564] [112/133] (558s left) kms_dsc (dsc-fractional-bpp)
[463.628594] Starting subtest: dsc-fractional-bpp
[463.641553] Subtest dsc-fractional-bpp: SKIP (0.001s)
[463.730940] [113/133] (558s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[463.832662] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[463.834948] Starting dynamic subtest: pipe-A-default-mode
[464.122635] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[464.127261] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.288s)
[465.011902] [114/133] (556s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[465.120742] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[465.124959] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[465.241510] [115/133] (556s left) gem_softpin (evict-prime)
[465.309817] Starting subtest: evict-prime
[465.312058] Starting dynamic subtest: rcs0
[466.504358] Dynamic subtest rcs0: SUCCESS (1.194s)
[466.517425] Starting dynamic subtest: bcs0
[467.662354] Dynamic subtest bcs0: SUCCESS (1.154s)
[467.675381] Starting dynamic subtest: vcs0
[469.303021] Dynamic subtest vcs0: SUCCESS (1.639s)
[469.314143] Starting dynamic subtest: vcs1
[471.309752] Dynamic subtest vcs1: SUCCESS (2.005s)
[471.322876] Starting dynamic subtest: vecs0
[473.371042] Dynamic subtest vecs0: SUCCESS (2.059s)
[473.381624] Starting dynamic subtest: ccs0
[474.525656] Dynamic subtest ccs0: SUCCESS (1.154s)
[474.538979] Starting dynamic subtest: all
[476.296640] Dynamic subtest all: SUCCESS (1.768s)
[476.299265] Subtest evict-prime: SUCCESS (10.988s)
[476.401842] [116/133] (545s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[476.499678] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[476.503634] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[476.629655] [117/133] (545s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[476.730242] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[476.846726] [118/133] (545s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[476.902409] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[477.007331] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[477.110961] [119/133] (544s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[477.199453] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[477.203644] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[477.338576] [120/133] (544s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[477.436960] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[481.479448] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.046s)
[482.715750] [121/133] (539s left) gem_mmap_wc (bad-size)
[482.779656] Subtest bad-size: SKIP (0.000s)
[482.851570] [122/133] (539s left) kms_hdr (static-toggle-suspend)
[482.941335] Starting subtest: static-toggle-suspend
[482.947708] Subtest static-toggle-suspend: SKIP (0.000s)
[483.040219] [123/133] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[483.147146] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[483.151484] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[483.280047] [124/133] (538s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[488.239565] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[488.241888] Starting dynamic subtest: pipe-A-eDP-1
[489.044302] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s)
[489.054853] Starting dynamic subtest: pipe-B-eDP-1
[490.169019] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[490.173736] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.928s)
[491.366582] [125/133] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[491.466212] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[491.470065] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[491.610847] [126/133] (530s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[491.714351] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[491.716649] Starting dynamic subtest: pipe-A-eDP-1
[491.738007] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[491.750532] Starting dynamic subtest: pipe-B-eDP-1
[491.769345] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[491.779039] Starting dynamic subtest: pipe-C-eDP-1
[491.798774] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[491.809513] Starting dynamic subtest: pipe-D-eDP-1
[491.828626] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[491.830741] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[493.939513] [127/133] (528s left) syncobj_timeline (single-wait-all-available-submitted)
[494.001951] Starting subtest: single-wait-all-available-submitted
[494.004188] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[494.115831] [128/133] (528s left) gem_exec_parallel (userptr)
[494.188599] Starting subtest: userptr
[494.190963] Starting dynamic subtest: rcs0
[495.663766] Dynamic subtest rcs0: SUCCESS (1.475s)
[495.677671] Starting dynamic subtest: bcs0
[497.171041] Dynamic subtest bcs0: SUCCESS (1.504s)
[497.184671] Starting dynamic subtest: vcs0
[499.314931] Dynamic subtest vcs0: SUCCESS (2.140s)
[499.327346] Starting dynamic subtest: vcs1
[501.298423] Dynamic subtest vcs1: SUCCESS (1.981s)
[501.309027] Starting dynamic subtest: vecs0
[503.346331] Dynamic subtest vecs0: SUCCESS (2.046s)
[503.356498] Starting dynamic subtest: ccs0
[504.880468] Dynamic subtest ccs0: SUCCESS (1.533s)
[504.882746] Subtest userptr: SUCCESS (10.695s)
[505.093782] [129/133] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[505.202773] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[505.206907] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[505.315659] [130/133] (517s left) i915_selftest (mock)
[507.339460] Starting subtest: mock
[507.342104] Starting dynamic subtest: sanitycheck
[508.069831] Dynamic subtest sanitycheck: SUCCESS (0.731s)
[508.079106] Starting dynamic subtest: shmem
[508.848757] Dynamic subtest shmem: SUCCESS (0.776s)
[508.858770] Starting dynamic subtest: fence
[516.518032] Dynamic subtest fence: SUCCESS (7.668s)
[516.527887] Starting dynamic subtest: scatterlist
[518.256593] Dynamic subtest scatterlist: SUCCESS (1.737s)
[518.271694] Starting dynamic subtest: syncmap
[522.063014] Dynamic subtest syncmap: SUCCESS (3.804s)
[522.073109] Starting dynamic subtest: uncore
[522.772460] Dynamic subtest uncore: SUCCESS (0.708s)
[522.781578] Starting dynamic subtest: ring
[523.484845] Dynamic subtest ring: SUCCESS (0.711s)
[523.500546] Starting dynamic subtest: engine
[524.186529] Dynamic subtest engine: SUCCESS (0.700s)
[524.196159] Starting dynamic subtest: timelines
[528.053755] Dynamic subtest timelines: SUCCESS (3.865s)
[528.063961] Starting dynamic subtest: requests
[531.569830] Dynamic subtest requests: SUCCESS (3.514s)
[531.579246] Starting dynamic subtest: objects
[532.423179] Dynamic subtest objects: SUCCESS (0.852s)
[532.432649] Starting dynamic subtest: phys
[533.315874] Dynamic subtest phys: SUCCESS (0.891s)
[533.325301] Starting dynamic subtest: dmabuf
[534.109783] Dynamic subtest dmabuf: SUCCESS (0.792s)
[534.119770] Starting dynamic subtest: vma
[539.513685] Dynamic subtest vma: SUCCESS (5.402s)
[539.522091] Starting dynamic subtest: evict
[541.093748] Dynamic subtest evict: SUCCESS (1.577s)
[541.103514] Starting dynamic subtest: gtt
[544.323664] Dynamic subtest gtt: SUCCESS (3.228s)
[544.333987] Starting dynamic subtest: hugepages
[545.232874] Dynamic subtest hugepages: SUCCESS (0.908s)
[545.243120] Starting dynamic subtest: memory_region
[547.854612] Dynamic subtest memory_region: SUCCESS (2.619s)
[547.857425] Subtest mock: SUCCESS (40.522s)
[547.885731] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[547.886431] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[547.889692] [131/133] (474s left) gem_mmap_gtt (basic-write-read)
[549.455947] Subtest basic-write-read: SKIP (0.000s)
[549.518279] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[549.519570] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[549.523332] [132/133] (472s left) perf (gen12-group-exclusive-stream-sample-oa)
[549.679091] Starting subtest: gen12-group-exclusive-stream-sample-oa
[549.699787] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.019s)
[549.748727] [133/133] (472s left) perf_pmu (busy-double-start)
[549.786023] Starting subtest: busy-double-start
[549.788260] Starting dynamic subtest: rcs0
[553.367339] Dynamic subtest rcs0: SUCCESS (3.582s)
[553.378368] Starting dynamic subtest: bcs0
[556.949283] Dynamic subtest bcs0: SUCCESS (3.580s)
[556.958445] Starting dynamic subtest: vcs0
[560.827133] Dynamic subtest vcs0: SUCCESS (3.876s)
[560.840205] Starting dynamic subtest: vcs1
[564.896205] Dynamic subtest vcs1: SUCCESS (4.067s)
[564.907382] Starting dynamic subtest: vecs0
[568.921354] Dynamic subtest vecs0: SUCCESS (4.023s)
[568.932758] Starting dynamic subtest: ccs0
[572.561889] Dynamic subtest ccs0: FAIL (3.585s)
[572.564276] Subtest busy-double-start: FAIL (22.726s)
[572.633269] 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.