[58.399006] Initializing watchdogs
[58.399056]   /dev/watchdog0
[58.413165] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.417729] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.419810] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.421679] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[58.493707] Subtest write-snoop: SKIP (0.000s)
[58.577137] [002/133] (960s left) kms_content_protection (content-type-change)
[58.733760] Starting subtest: content-type-change
[58.735637] Subtest content-type-change: SKIP (0.000s)
[58.873512] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[58.979520] Starting subtest: multiplane-rotation
[76.368732] Subtest multiplane-rotation: SUCCESS (17.402s)
[76.509484] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[76.601872] Subtest ctm-red-to-blue: SKIP (0.000s)
[76.638518] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[76.696857] Starting subtest: invalid-reset-one-illegal-handle
[76.698406] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[76.856052] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[76.948226] Starting subtest: disable-crc-after-crtc
[76.949350] Starting dynamic subtest: pipe-A-eDP-1
[78.660438] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.712s)
[78.666693] Starting dynamic subtest: pipe-B-eDP-1
[80.901910] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.240s)
[80.908067] Starting dynamic subtest: pipe-C-eDP-1
[83.141068] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.239s)
[83.147184] Starting dynamic subtest: pipe-D-eDP-1
[85.403436] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.261s)
[85.404282] Subtest disable-crc-after-crtc: SUCCESS (8.457s)
[86.252037] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[86.317240] Subtest tiled-to-tiled: SKIP (0.000s)
[86.367447] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[86.410293] Starting subtest: wait-all-interrupted
[86.515791] Subtest wait-all-interrupted: SUCCESS (0.102s)
[86.624147] [009/133] (932s left) syncobj_wait (wait-all-complex)
[86.693049] Starting subtest: wait-all-complex
[86.908203] Subtest wait-all-complex: SUCCESS (0.213s)
[86.997629] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[87.113686] Starting subtest: reject-modify-context-protection-on
[87.114924] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[87.237968] [011/133] (932s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[87.352802] Starting subtest: cursorA-vs-flipB-varying-size
[87.354584] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[87.511821] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[87.608304] Starting subtest: primary-rotation-90
[87.610033] Subtest primary-rotation-90: SKIP (0.001s)
[87.698373] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[87.746410] Starting subtest: reset-multiple-signaled
[87.747493] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[87.870611] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[87.970266] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[87.971972] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[89.079933] [015/133] (930s left) gem_softpin (noreloc-s3)
[89.145402] Starting subtest: noreloc-S3
[108.983279] Subtest noreloc-S3: SUCCESS (5.418s)
[115.140072] [016/133] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[115.235992] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[119.694328] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.475s)
[120.815659] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[120.866456] Starting subtest: invalid-ctx-set
[120.867469] Subtest invalid-ctx-set: SUCCESS (0.001s)
[120.987870] [018/133] (904s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[121.048889] Starting subtest: single-wait-all-for-submit-unsubmitted
[121.149993] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[121.242137] [019/133] (904s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[121.339865] Starting subtest: x-tiled-64bpp-rotate-90
[121.359425] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[121.503490] [020/133] (904s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[121.567020] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[121.627813] [021/133] (903s left) kms_psr (fbc-psr-cursor-plane-move)
[121.735476] Starting subtest: fbc-psr-cursor-plane-move
[121.736469] Starting dynamic subtest: eDP-1
[121.738275] Dynamic subtest eDP-1: SKIP (0.000s)
[121.739897] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[121.862810] [022/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[121.973005] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[122.971598] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.001s)
[123.130467] [023/133] (902s left) kms_flip (2x-flip-vs-rmfb)
[123.230840] Starting subtest: 2x-flip-vs-rmfb
[123.243578] Subtest 2x-flip-vs-rmfb: SKIP (0.013s)
[123.361732] [024/133] (902s left) kms_plane_cursor (viewport)
[123.458413] Starting subtest: viewport
[123.460170] Starting dynamic subtest: pipe-A-eDP-1-size-64
[125.828204] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.374s)
[125.888692] Starting dynamic subtest: pipe-A-eDP-1-size-128
[128.314552] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.438s)
[128.375132] Starting dynamic subtest: pipe-A-eDP-1-size-256
[130.770864] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.407s)
[131.114110] Starting dynamic subtest: pipe-B-eDP-1-size-64
[134.183030] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.078s)
[134.244600] Starting dynamic subtest: pipe-B-eDP-1-size-128
[136.647960] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.415s)
[136.709367] Starting dynamic subtest: pipe-B-eDP-1-size-256
[139.069510] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.371s)
[139.414564] Starting dynamic subtest: pipe-C-eDP-1-size-64
[142.211360] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.805s)
[142.252503] Starting dynamic subtest: pipe-C-eDP-1-size-128
[144.254476] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.013s)
[144.292880] Starting dynamic subtest: pipe-C-eDP-1-size-256
[146.333147] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.047s)
[146.656698] Starting dynamic subtest: pipe-D-eDP-1-size-64
[149.452364] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.801s)
[149.488004] Starting dynamic subtest: pipe-D-eDP-1-size-128
[151.607154] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.125s)
[151.645208] Starting dynamic subtest: pipe-D-eDP-1-size-256
[153.696982] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.058s)
[154.016094] Subtest viewport: SUCCESS (30.575s)
[154.910159] [025/133] (870s left) kms_cdclk (mode-transition)
[155.000384] Starting subtest: mode-transition
[155.001279] Starting dynamic subtest: pipe-A-eDP-1
[155.290374] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s)
[155.297452] Starting dynamic subtest: pipe-B-eDP-1
[155.299227] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[155.305960] Starting dynamic subtest: pipe-C-eDP-1
[155.307823] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[155.314567] Starting dynamic subtest: pipe-D-eDP-1
[155.316346] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[155.317985] Subtest mode-transition: SKIP (0.296s)
[156.135136] [026/133] (869s left) gem_exec_balancer (fairslice)
[156.201659] Starting subtest: fairslice
[159.077984] Subtest fairslice: SUCCESS (2.873s)
[160.425883] [027/133] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[160.547867] Starting subtest: basic-flip-before-cursor-varying-size
[161.476583] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.927s)
[162.369595] [028/133] (863s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[162.464202] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[162.466158] Starting dynamic subtest: pipe-A-default-mode
[162.750041] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[162.751666] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.285s)
[163.589650] [029/133] (862s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[163.692457] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[163.693245] Starting dynamic subtest: pipe-A-default-mode
[166.439475] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s)
[166.440428] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.748s)
[167.289468] [030/133] (858s left) core_getstats (basic)
[167.332291] Starting subtest: basic
[167.333211] Subtest basic: SUCCESS (0.000s)
[167.457869] [031/133] (858s left) kms_rmfb (close-fd)
[167.561431] Starting subtest: close-fd
[167.562383] Starting dynamic subtest: pipe-A-eDP-1
[167.669138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[167.676503] Starting dynamic subtest: pipe-B-eDP-1
[168.844966] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.176s)
[168.852811] Starting dynamic subtest: pipe-C-eDP-1
[169.973376] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[169.980448] Starting dynamic subtest: pipe-D-eDP-1
[171.099196] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[171.100115] Subtest close-fd: SUCCESS (3.539s)
[172.320330] [032/133] (853s left) gem_exec_reloc (basic-gtt-wc)
[172.385767] Subtest basic-gtt-wc: SKIP (0.000s)
[172.458575] [033/133] (853s left) kms_properties (crtc-properties-legacy)
[172.557502] Starting subtest: crtc-properties-legacy
[172.558373] Starting dynamic subtest: pipe-A-eDP-1
[173.000331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[173.009108] Starting dynamic subtest: pipe-B-eDP-1
[174.166504] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s)
[174.174628] Starting dynamic subtest: pipe-C-eDP-1
[175.293791] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[175.305602] Starting dynamic subtest: pipe-D-eDP-1
[176.423724] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[176.424620] Subtest crtc-properties-legacy: SUCCESS (3.868s)
[177.248733] [034/133] (848s left) kms_invalid_mode (zero-hdisplay)
[177.346154] Starting subtest: zero-hdisplay
[177.347088] Starting dynamic subtest: pipe-A-eDP-1
[177.634196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[177.640975] Starting dynamic subtest: pipe-B-eDP-1
[177.641770] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[177.648276] Starting dynamic subtest: pipe-C-eDP-1
[177.649111] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[177.655500] Starting dynamic subtest: pipe-D-eDP-1
[177.656294] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[177.657122] Subtest zero-hdisplay: SUCCESS (0.295s)
[178.474545] [035/133] (847s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[178.558333] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[178.559192] Starting dynamic subtest: pipe-A
[179.617652] Dynamic subtest pipe-A: SUCCESS (1.060s)
[179.624723] Starting dynamic subtest: pipe-B
[181.766916] Dynamic subtest pipe-B: SUCCESS (2.148s)
[181.781160] Starting dynamic subtest: pipe-C
[182.964907] Dynamic subtest pipe-C: SUCCESS (1.197s)
[182.972438] Starting dynamic subtest: pipe-D
[184.119602] Dynamic subtest pipe-D: SUCCESS (1.154s)
[184.120597] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.564s)
[185.329514] [036/133] (840s left) kms_pm_rpm (legacy-planes-dpms)
[187.487978] Starting subtest: legacy-planes-dpms
[187.489110] Starting dynamic subtest: plane-63
[196.063670] Dynamic subtest plane-63: SUCCESS (8.580s)
[196.074518] Starting dynamic subtest: plane-93
[204.658113] Dynamic subtest plane-93: SUCCESS (8.595s)
[204.668039] Starting dynamic subtest: plane-123
[212.953763] Dynamic subtest plane-123: SUCCESS (8.292s)
[212.965544] Starting dynamic subtest: plane-133
[221.269192] Dynamic subtest plane-133: SUCCESS (8.309s)
[221.273590] Subtest legacy-planes-dpms: SUCCESS (33.788s)
[221.651813] [037/133] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[221.751996] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[221.753741] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[221.884957] [038/133] (804s left) kms_dirtyfb (default-dirtyfb-ioctl)
[221.973471] Starting subtest: default-dirtyfb-ioctl
[221.974473] Starting dynamic subtest: A-eDP-1
[223.552768] Dynamic subtest A-eDP-1: SUCCESS (1.578s)
[223.553678] Subtest default-dirtyfb-ioctl: SUCCESS (1.579s)
[224.376249] [039/133] (801s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[224.487639] Starting subtest: cursorB-vs-flipA-legacy
[224.490699] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[224.649286] [040/133] (801s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[224.704794] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[224.705672] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[224.839037] [041/133] (801s left) kms_prime (basic-crc-vgem)
[224.958596] Starting subtest: basic-crc-vgem
[224.959423] Starting dynamic subtest: second-to-first
[225.915919] Dynamic subtest second-to-first: SUCCESS (0.957s)
[225.916873] Subtest basic-crc-vgem: SUCCESS (0.958s)
[226.023677] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[226.025859] [042/133] (800s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[226.124972] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[226.193365] [043/133] (800s left) i915_drm_fdinfo (busy)
[226.229959] Starting subtest: busy
[226.230930] Starting dynamic subtest: rcs0
[226.268586] Dynamic subtest rcs0: SKIP (0.037s)
[226.279392] Starting dynamic subtest: bcs0
[226.281192] Dynamic subtest bcs0: SKIP (0.001s)
[226.288382] Starting dynamic subtest: vcs0
[226.290209] Dynamic subtest vcs0: SKIP (0.000s)
[226.297348] Starting dynamic subtest: vcs1
[226.299030] Dynamic subtest vcs1: SKIP (0.000s)
[226.305919] Starting dynamic subtest: vecs0
[226.307765] Dynamic subtest vecs0: SKIP (0.000s)
[226.314886] Starting dynamic subtest: ccs0
[226.316781] Dynamic subtest ccs0: SKIP (0.000s)
[226.318619] Subtest busy: SKIP (0.046s)
[226.366688] [044/133] (799s left) gem_userptr_blits (nohangcheck)
[226.438871] Starting subtest: nohangcheck
[226.725459] Subtest nohangcheck: SUCCESS (0.284s)
[226.878928] [045/133] (799s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[226.981370] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[227.595733] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.614s)
[227.788561] [046/133] (798s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[227.887445] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[227.889252] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[229.011803] [047/133] (797s left) kms_scaling_modes (scaling-mode-full)
[229.108327] Starting subtest: scaling-mode-full
[229.109190] Starting dynamic subtest: pipe-A-eDP-1
[229.205134] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[229.216668] Starting dynamic subtest: pipe-B-eDP-1
[230.406583] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s)
[230.415679] Starting dynamic subtest: pipe-C-eDP-1
[231.528002] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[231.537220] Starting dynamic subtest: pipe-D-eDP-1
[232.647980] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s)
[232.648967] Subtest scaling-mode-full: SUCCESS (3.540s)
[233.852651] [048/133] (792s left) kms_psr (fbc-pr-basic)
[233.951495] Starting subtest: fbc-pr-basic
[233.953336] Subtest fbc-pr-basic: SKIP (0.000s)
[234.047599] [049/133] (792s left) gem_ringfill (basic-all)
[239.341764] Starting subtest: basic-all
[240.502143] Subtest basic-all: SUCCESS (1.159s)
[240.668026] [050/133] (785s left) gem_exec_whisper (basic-fds-forked-all)
[240.731619] Starting subtest: basic-fds-forked-all
[264.265410] Subtest basic-fds-forked-all: SUCCESS (23.535s)
[264.467922] [051/133] (762s left) api_intel_bb (full-batch)
[264.520546] Starting subtest: full-batch
[264.531585] Subtest full-batch: SUCCESS (0.011s)
[264.674609] [052/133] (761s left) kms_cursor_crc (cursor-sliding-256x85)
[264.925326] Starting subtest: cursor-sliding-256x85
[264.967670] Subtest cursor-sliding-256x85: SKIP (0.040s)
[265.176936] [053/133] (761s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[265.275812] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[265.276773] Starting dynamic subtest: pipe-A-eDP-1
[265.298422] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[265.306183] Starting dynamic subtest: pipe-B-eDP-1
[265.327735] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[265.335182] Starting dynamic subtest: pipe-C-eDP-1
[265.356497] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[265.363794] Starting dynamic subtest: pipe-D-eDP-1
[265.385731] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[265.387472] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.010s)
[267.512961] [054/133] (759s left) gen9_exec_parse (allowed-single)
[267.565678] Subtest allowed-single: SKIP (0.000s)
[267.649854] [055/133] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[267.742763] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[274.753316] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.012s)
[274.898340] [056/133] (751s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[275.002391] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[275.004120] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[275.126675] [057/133] (751s left) gem_exec_fence (expired-history)
[275.610779] Starting subtest: expired-history
[283.054114] Subtest expired-history: SUCCESS (7.444s)
[285.486083] [058/133] (741s left) kms_psr (fbc-psr-sprite-plane-move)
[285.579285] Starting subtest: fbc-psr-sprite-plane-move
[285.580177] Starting dynamic subtest: eDP-1
[285.582116] Dynamic subtest eDP-1: SKIP (0.000s)
[285.583841] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[285.674147] [059/133] (741s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[285.776364] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[292.462020] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.688s)
[292.627425] [060/133] (734s left) gem_ctx_bad_destroy (double-destroy)
[292.686636] Starting subtest: double-destroy
[292.687704] Subtest double-destroy: SUCCESS (0.000s)
[292.777777] [061/133] (734s left) syncobj_timeline (invalid-signal-illegal-handle)
[292.840074] Starting subtest: invalid-signal-illegal-handle
[292.841159] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[292.958523] [062/133] (734s left) kms_chamelium_hpd (common-hpd-after-suspend)
[293.347793] Subtest common-hpd-after-suspend: SKIP (0.000s)
[294.180425] [063/133] (732s left) kms_frontbuffer_tracking (fbc-tiling-4)
[294.272872] Starting subtest: fbc-tiling-4
[298.567574] Subtest fbc-tiling-4: SUCCESS (4.295s)
[299.737038] [064/133] (727s left) gem_cs_tlb (engines)
[299.802411] Starting subtest: engines
[299.803433] Starting dynamic subtest: rcs0
[301.957780] Dynamic subtest rcs0: SUCCESS (2.152s)
[301.968095] Starting dynamic subtest: bcs0
[304.108728] Dynamic subtest bcs0: SUCCESS (2.150s)
[304.119228] Starting dynamic subtest: vcs0
[306.261008] Dynamic subtest vcs0: SUCCESS (2.151s)
[306.271204] Starting dynamic subtest: vcs1
[308.413900] Dynamic subtest vcs1: SUCCESS (2.153s)
[308.424125] Starting dynamic subtest: vecs0
[310.566574] Dynamic subtest vecs0: SUCCESS (2.152s)
[310.577027] Starting dynamic subtest: ccs0
[312.718846] Dynamic subtest ccs0: SUCCESS (2.152s)
[312.720073] Subtest engines: SUCCESS (12.916s)
[312.890324] [065/133] (714s left) gem_mmap_gtt (hang-busy)
[312.950889] Subtest hang-busy: SKIP (0.000s)
[313.013864] [066/133] (714s left) kms_psr (psr2-sprite-plane-onoff)
[313.099097] Starting subtest: psr2-sprite-plane-onoff
[313.099919] Starting dynamic subtest: eDP-1
[314.838941] Dynamic subtest eDP-1: SUCCESS (1.739s)
[314.839970] Subtest psr2-sprite-plane-onoff: SUCCESS (1.740s)
[315.696646] [067/133] (711s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[315.791294] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[316.438550] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[316.605111] [068/133] (710s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[316.706914] Starting subtest: y-tiled-64bpp-rotate-270
[316.708778] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[316.846834] [069/133] (710s left) gem_bad_reloc (negative-reloc-lut)
[316.904001] Subtest negative-reloc-lut: SKIP (0.000s)
[316.977605] [070/133] (710s left) gem_ctx_persistence (engines-mixed)
[317.041354] Starting subtest: engines-mixed
[317.042381] Starting dynamic subtest: rcs0
[317.162300] Dynamic subtest rcs0: SUCCESS (0.120s)
[317.173133] Starting dynamic subtest: bcs0
[317.242596] Dynamic subtest bcs0: SUCCESS (0.079s)
[317.253701] Starting dynamic subtest: vcs0
[317.307783] Dynamic subtest vcs0: SUCCESS (0.063s)
[317.318916] Starting dynamic subtest: vcs1
[317.370033] Dynamic subtest vcs1: SUCCESS (0.060s)
[317.381578] Starting dynamic subtest: vecs0
[317.423917] Dynamic subtest vecs0: SUCCESS (0.052s)
[317.434844] Starting dynamic subtest: ccs0
[317.493934] Dynamic subtest ccs0: SUCCESS (0.068s)
[317.495628] Subtest engines-mixed: SUCCESS (0.453s)
[317.591569] [071/133] (709s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[317.679220] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[317.680124] Starting dynamic subtest: pipe-A
[317.744818] Dynamic subtest pipe-A: SUCCESS (0.065s)
[317.756685] Starting dynamic subtest: pipe-B
[318.906349] Dynamic subtest pipe-B: SUCCESS (1.159s)
[318.918248] Starting dynamic subtest: pipe-C
[320.016940] Dynamic subtest pipe-C: SUCCESS (1.108s)
[320.026801] Starting dynamic subtest: pipe-D
[321.152824] Dynamic subtest pipe-D: SUCCESS (1.135s)
[321.153781] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.475s)
[322.331876] [072/133] (704s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[322.437937] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[322.439756] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[322.573038] [073/133] (704s left) gem_exec_schedule (semaphore-noskip)
[322.644348] Starting subtest: semaphore-noskip
[323.080824] Subtest semaphore-noskip: SUCCESS (0.434s)
[323.438896] [074/133] (703s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[323.537704] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[323.539412] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[323.668581] [075/133] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[323.761128] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[323.762943] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[323.891010] [076/133] (703s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[323.988832] Starting subtest: 4-tiled-16bpp-rotate-0
[325.193967] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.206s)
[325.366700] [077/133] (702s left) gem_exec_basic (basic)
[325.432939] Starting subtest: basic
[325.433955] Starting dynamic subtest: rcs0-smem
[325.436502] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[325.444734] Starting dynamic subtest: bcs0-smem
[325.445629] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[325.453010] Starting dynamic subtest: vcs0-smem
[325.453911] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[325.461151] Starting dynamic subtest: vcs1-smem
[325.462047] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[325.469507] Starting dynamic subtest: vecs0-smem
[325.470368] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[325.477731] Starting dynamic subtest: ccs0-smem
[325.478633] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[325.479543] Subtest basic: SUCCESS (0.014s)
[327.394557] [078/133] (700s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[327.487603] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[327.489194] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[327.634750] [079/133] (699s left) gem_mmap (short-mmap)
[327.681785] Subtest short-mmap: SKIP (0.000s)
[327.744831] [080/133] (699s left) gem_exec_reloc (basic-gtt-wc-active)
[327.801891] Subtest basic-gtt-wc-active: SKIP (0.000s)
[327.879837] [081/133] (699s left) gem_ctx_shared (create-shared-gtt)
[327.940829] Starting subtest: create-shared-gtt
[330.095046] Subtest create-shared-gtt: SUCCESS (2.153s)
[330.542844] [082/133] (697s left) gem_exec_reloc (basic-write-wc)
[330.595864] Subtest basic-write-wc: SKIP (0.000s)
[330.671366] [083/133] (697s left) gem_eio (wait-immediate)
[330.925309] Starting subtest: wait-immediate
[331.334943] Subtest wait-immediate: SUCCESS (0.410s)
[331.507129] [084/133] (696s left) gem_ctx_persistence (legacy-engines-mixed)
[331.567931] Starting subtest: legacy-engines-mixed
[331.568955] Starting dynamic subtest: render
[331.693676] Dynamic subtest render: SUCCESS (0.125s)
[331.705418] Starting dynamic subtest: bsd1
[331.766786] Dynamic subtest bsd1: SUCCESS (0.070s)
[331.778173] Starting dynamic subtest: bsd2
[331.848319] Dynamic subtest bsd2: SUCCESS (0.078s)
[331.858980] Starting dynamic subtest: blt
[331.928352] Dynamic subtest blt: SUCCESS (0.077s)
[331.940431] Starting dynamic subtest: vebox
[332.009188] Dynamic subtest vebox: SUCCESS (0.078s)
[332.010552] Subtest legacy-engines-mixed: SUCCESS (0.442s)
[332.101940] [085/133] (695s left) perf_pmu (semaphore-busy)
[332.145779] Starting subtest: semaphore-busy
[332.146689] Starting dynamic subtest: rcs0
[333.818366] Dynamic subtest rcs0: SUCCESS (1.669s)
[333.828785] Starting dynamic subtest: bcs0
[335.454135] Dynamic subtest bcs0: SUCCESS (1.633s)
[335.464036] Starting dynamic subtest: vcs0
[339.814861] Dynamic subtest vcs0: SUCCESS (4.358s)
[339.824693] Starting dynamic subtest: vcs1
[345.828098] Dynamic subtest vcs1: SUCCESS (6.008s)
[345.838101] Starting dynamic subtest: vecs0
[351.846228] Dynamic subtest vecs0: SUCCESS (6.014s)
[351.856493] Starting dynamic subtest: ccs0
[354.921605] Dynamic subtest ccs0: SUCCESS (3.071s)
[354.922805] Subtest semaphore-busy: SUCCESS (22.769s)
[355.056242] [086/133] (672s left) gem_exec_schedule (pi-common)
[355.252672] Starting subtest: pi-common
[355.253861] Starting dynamic subtest: rcs0
[355.295933] Dynamic subtest rcs0: SUCCESS (0.044s)
[355.304906] Starting dynamic subtest: bcs0
[355.330868] Dynamic subtest bcs0: SUCCESS (0.034s)
[355.339354] Starting dynamic subtest: vcs0
[355.376194] Dynamic subtest vcs0: SUCCESS (0.044s)
[355.384818] Starting dynamic subtest: vcs1
[355.409990] Dynamic subtest vcs1: SUCCESS (0.033s)
[355.418323] Starting dynamic subtest: vecs0
[355.442560] Dynamic subtest vecs0: SUCCESS (0.032s)
[355.451132] Starting dynamic subtest: ccs0
[355.473965] Dynamic subtest ccs0: SUCCESS (0.031s)
[355.475360] Subtest pi-common: SUCCESS (0.223s)
[355.730135] [087/133] (672s left) i915_hangman (engine-error-state-capture)
[355.807563] Starting subtest: engine-error-state-capture
[355.808509] Starting dynamic subtest: rcs0
[359.306597] Dynamic subtest rcs0: SUCCESS (3.495s)
[359.318340] Starting dynamic subtest: bcs0
[365.322118] Dynamic subtest bcs0: SUCCESS (6.011s)
[365.333103] Starting dynamic subtest: vcs0
[370.249220] Dynamic subtest vcs0: SUCCESS (4.923s)
[370.259807] Starting dynamic subtest: vcs1
[375.241842] Dynamic subtest vcs1: SUCCESS (4.989s)
[375.253027] Starting dynamic subtest: vecs0
[380.233621] Dynamic subtest vecs0: SUCCESS (4.989s)
[380.244750] Starting dynamic subtest: ccs0
[386.314009] Dynamic subtest ccs0: SUCCESS (6.077s)
[386.315828] Subtest engine-error-state-capture: SUCCESS (30.501s)
[386.481170] [088/133] (641s left) syncobj_timeline (wait-for-submit-snapshot)
[386.528650] Starting subtest: wait-for-submit-snapshot
[386.611187] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[386.708726] [089/133] (641s left) kms_color (ctm-blue-to-red)
[386.809114] Starting subtest: ctm-blue-to-red
[386.809978] Starting dynamic subtest: pipe-A-eDP-1
[387.494021] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[387.502452] Starting dynamic subtest: pipe-B-eDP-1
[388.879603] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[388.888138] Starting dynamic subtest: pipe-C-eDP-1
[390.165212] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.285s)
[390.173806] Starting dynamic subtest: pipe-D-eDP-1
[391.475585] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.310s)
[391.476504] Subtest ctm-blue-to-red: SUCCESS (4.668s)
[392.348627] [090/133] (635s left) prime_vgem (basic-gtt)
[392.462593] Starting subtest: basic-gtt
[392.464737] Subtest basic-gtt: SKIP (0.000s)
[392.593247] [091/133] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[392.703550] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[400.251143] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.548s)
[400.394168] [092/133] (627s left) api_intel_allocator (default-alignment)
[400.442423] Starting subtest: default-alignment
[400.445358] Subtest default-alignment: SUCCESS (0.003s)
[400.570987] [093/133] (627s left) i915_pm_rps (fence-order)
[400.635128] Starting subtest: fence-order
[404.088591] Subtest fence-order: SUCCESS (3.453s)
[404.243834] [094/133] (623s left) kms_vblank (query-busy)
[404.349452] Starting subtest: query-busy
[404.350406] Starting dynamic subtest: pipe-A-eDP-1
[406.232236] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[406.243166] Starting dynamic subtest: pipe-D-eDP-1
[408.748906] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.514s)
[408.749815] Subtest query-busy: SUCCESS (4.400s)
[409.579600] [095/133] (618s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[409.678753] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[409.680648] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[409.812449] [096/133] (618s left) kms_addfb_basic (invalid-get-prop-any)
[409.873594] Starting subtest: invalid-get-prop-any
[409.874540] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[410.040061] [097/133] (618s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[410.142339] Starting subtest: fbc-psr2-cursor-mmap-gtt
[410.143126] Starting dynamic subtest: eDP-1
[410.144800] Dynamic subtest eDP-1: SKIP (0.000s)
[410.146460] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[410.236166] [098/133] (617s left) kms_flip (2x-blocking-absolute-wf_vblank)
[410.312763] Starting subtest: 2x-blocking-absolute-wf_vblank
[410.324144] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[410.445172] [099/133] (617s left) kms_cursor_crc (cursor-onscreen-256x85)
[410.701452] Starting subtest: cursor-onscreen-256x85
[410.741145] Subtest cursor-onscreen-256x85: SKIP (0.038s)
[410.944286] [100/133] (617s left) kms_flip (2x-modeset-vs-vblank-race)
[411.043232] Starting subtest: 2x-modeset-vs-vblank-race
[411.056197] Subtest 2x-modeset-vs-vblank-race: SKIP (0.013s)
[411.173572] [101/133] (617s left) kms_atomic_interruptible (atomic-setmode)
[411.254142] Starting subtest: atomic-setmode
[411.254933] Starting dynamic subtest: pipe-A-eDP-1
[418.131886] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.876s)
[418.132834] Subtest atomic-setmode: SUCCESS (6.877s)
[418.949392] [102/133] (609s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[419.044216] Starting subtest: psr-argb161616f-draw-render
[419.045888] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[419.175738] [103/133] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[419.282083] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[419.283866] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[419.418970] [104/133] (608s left) kms_plane_scaling (invalid-num-scalers)
[419.501432] Starting subtest: invalid-num-scalers
[419.502312] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[419.518547] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[419.527217] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[419.548163] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[419.556553] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[419.578127] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[419.590521] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[419.608104] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[419.608927] Subtest invalid-num-scalers: SUCCESS (0.108s)
[419.741926] [105/133] (608s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[419.851819] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[419.853465] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[419.978409] [106/133] (608s left) sw_sync (alloc_fence_invalid_timeline)
[420.009353] Starting subtest: alloc_fence_invalid_timeline
[420.010335] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[420.074780] [107/133] (608s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[420.123435] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[420.231806] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[420.325458] [108/133] (608s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[420.417605] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[420.419913] Starting dynamic subtest: A-eDP1
[429.285771] Dynamic subtest A-eDP1: SUCCESS (8.866s)
[429.296227] Starting dynamic subtest: B-eDP1
[438.208914] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[438.221965] Starting dynamic subtest: C-eDP1
[447.131169] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[447.141259] Starting dynamic subtest: D-eDP1
[455.972756] Dynamic subtest D-eDP1: SUCCESS (8.841s)
[455.974885] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.560s)
[457.213406] [109/133] (571s left) kms_addfb_basic (size-max)
[457.303319] Starting subtest: size-max
[457.304183] Subtest size-max: SUCCESS (0.000s)
[457.439372] [110/133] (571s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[457.673358] Starting subtest: cursor-rapid-movement-256x256
[457.676670] Starting dynamic subtest: pipe-A-eDP-1
[458.208681] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.532s)
[458.238030] Starting dynamic subtest: pipe-D-eDP-1
[459.400142] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.170s)
[459.401032] Subtest cursor-rapid-movement-256x256: SUCCESS (1.726s)
[460.265323] [111/133] (568s left) gem_exec_whisper (basic-queues-all)
[460.338872] Starting subtest: basic-queues-all
[468.619384] Subtest basic-queues-all: SUCCESS (8.282s)
[468.825719] [112/133] (559s left) kms_dsc (dsc-fractional-bpp)
[468.938329] Starting subtest: dsc-fractional-bpp
[468.943435] Subtest dsc-fractional-bpp: SKIP (0.000s)
[469.033653] [113/133] (559s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[469.126609] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[469.127543] Starting dynamic subtest: pipe-A-default-mode
[469.412945] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[469.414749] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.286s)
[470.297417] [114/133] (558s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[470.397788] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[470.399432] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[470.534812] [115/133] (558s left) gem_softpin (evict-prime)
[470.596644] Starting subtest: evict-prime
[470.597697] Starting dynamic subtest: rcs0
[471.803051] Dynamic subtest rcs0: SUCCESS (1.206s)
[471.815957] Starting dynamic subtest: bcs0
[472.957610] Dynamic subtest bcs0: SUCCESS (1.153s)
[472.970588] Starting dynamic subtest: vcs0
[474.321483] Dynamic subtest vcs0: SUCCESS (1.359s)
[474.333296] Starting dynamic subtest: vcs1
[476.366162] Dynamic subtest vcs1: SUCCESS (2.043s)
[476.376927] Starting dynamic subtest: vecs0
[478.355101] Dynamic subtest vecs0: SUCCESS (1.987s)
[478.366941] Starting dynamic subtest: ccs0
[479.513924] Dynamic subtest ccs0: SUCCESS (1.159s)
[479.527109] Starting dynamic subtest: all
[481.241748] Dynamic subtest all: SUCCESS (1.723s)
[481.243399] Subtest evict-prime: SUCCESS (10.646s)
[481.412544] [116/133] (547s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[481.512945] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[481.514679] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[481.644638] [117/133] (547s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[481.723202] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[481.829306] [118/133] (547s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[481.886094] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[481.991825] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[482.087637] [119/133] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[482.171678] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[482.173384] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[482.293777] [120/133] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[482.387407] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[486.488178] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.101s)
[487.684938] [121/133] (541s left) gem_mmap_wc (bad-size)
[487.734176] Subtest bad-size: SKIP (0.000s)
[487.788042] [122/133] (541s left) kms_hdr (static-toggle-suspend)
[487.887411] Starting subtest: static-toggle-suspend
[487.890156] Subtest static-toggle-suspend: SKIP (0.000s)
[487.982993] [123/133] (541s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[488.072350] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[488.073913] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[488.203375] [124/133] (540s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[493.248984] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[493.249927] Starting dynamic subtest: pipe-A-eDP-1
[494.045110] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s)
[494.055600] Starting dynamic subtest: pipe-B-eDP-1
[495.177927] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[495.180131] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.930s)
[496.380631] [125/133] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[496.488089] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[496.489719] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[496.634028] [126/133] (532s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[496.721207] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[496.722094] Starting dynamic subtest: pipe-A-eDP-1
[496.729566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[496.737930] Starting dynamic subtest: pipe-B-eDP-1
[496.746616] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[496.756440] Starting dynamic subtest: pipe-C-eDP-1
[496.763745] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[496.771950] Starting dynamic subtest: pipe-D-eDP-1
[496.779258] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[496.780107] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[498.947049] [127/133] (530s left) syncobj_timeline (single-wait-all-available-submitted)
[499.009881] Starting subtest: single-wait-all-available-submitted
[499.010929] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[499.142028] [128/133] (530s left) gem_exec_parallel (userptr)
[499.199553] Starting subtest: userptr
[499.200472] Starting dynamic subtest: rcs0
[500.655307] Dynamic subtest rcs0: SUCCESS (1.457s)
[500.666983] Starting dynamic subtest: bcs0
[502.150247] Dynamic subtest bcs0: SUCCESS (1.493s)
[502.161507] Starting dynamic subtest: vcs0
[504.299641] Dynamic subtest vcs0: SUCCESS (2.146s)
[504.310881] Starting dynamic subtest: vcs1
[506.283428] Dynamic subtest vcs1: SUCCESS (1.982s)
[506.294623] Starting dynamic subtest: vecs0
[508.266738] Dynamic subtest vecs0: SUCCESS (1.982s)
[508.275965] Starting dynamic subtest: ccs0
[509.763467] Dynamic subtest ccs0: SUCCESS (1.496s)
[509.766714] Subtest userptr: SUCCESS (10.568s)
[509.969856] [129/133] (519s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[510.070685] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[510.072393] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[510.211605] [130/133] (519s left) i915_selftest (mock)
[513.762507] Starting subtest: mock
[513.764024] Starting dynamic subtest: sanitycheck
[514.453876] Dynamic subtest sanitycheck: SUCCESS (0.692s)
[514.462426] Starting dynamic subtest: shmem
[515.132027] Dynamic subtest shmem: SUCCESS (0.676s)
[515.140096] Starting dynamic subtest: fence
[522.524825] Dynamic subtest fence: SUCCESS (7.392s)
[522.533161] Starting dynamic subtest: scatterlist
[524.202947] Dynamic subtest scatterlist: SUCCESS (1.676s)
[524.211693] Starting dynamic subtest: syncmap
[527.424719] Dynamic subtest syncmap: SUCCESS (3.220s)
[527.433280] Starting dynamic subtest: uncore
[528.012960] Dynamic subtest uncore: SUCCESS (0.587s)
[528.021702] Starting dynamic subtest: ring
[528.629006] Dynamic subtest ring: SUCCESS (0.614s)
[528.637362] Starting dynamic subtest: engine
[529.286930] Dynamic subtest engine: SUCCESS (0.656s)
[529.295790] Starting dynamic subtest: timelines
[533.194079] Dynamic subtest timelines: SUCCESS (3.905s)
[533.202629] Starting dynamic subtest: requests
[536.777879] Dynamic subtest requests: SUCCESS (3.582s)
[536.786491] Starting dynamic subtest: objects
[537.583183] Dynamic subtest objects: SUCCESS (0.804s)
[537.591411] Starting dynamic subtest: phys
[538.368043] Dynamic subtest phys: SUCCESS (0.783s)
[538.376209] Starting dynamic subtest: dmabuf
[539.117011] Dynamic subtest dmabuf: SUCCESS (0.747s)
[539.125441] Starting dynamic subtest: vma
[544.496871] Dynamic subtest vma: SUCCESS (5.378s)
[544.505410] Starting dynamic subtest: evict
[545.915978] Dynamic subtest evict: SUCCESS (1.417s)
[545.924891] Starting dynamic subtest: gtt
[549.147932] Dynamic subtest gtt: SUCCESS (3.230s)
[549.156561] Starting dynamic subtest: hugepages
[550.125827] Dynamic subtest hugepages: SUCCESS (0.976s)
[550.134562] Starting dynamic subtest: memory_region
[552.787739] Dynamic subtest memory_region: SUCCESS (2.660s)
[552.788943] Subtest mock: SUCCESS (39.033s)
[552.811456] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[552.812143] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[552.813796] [131/133] (476s left) gem_mmap_gtt (basic-write-read)
[554.265220] Subtest basic-write-read: SKIP (0.000s)
[554.320976] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[554.322518] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[554.324777] [132/133] (475s left) perf (gen12-group-exclusive-stream-sample-oa)
[554.464005] Starting subtest: gen12-group-exclusive-stream-sample-oa
[554.485110] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s)
[554.525921] [133/133] (474s left) perf_pmu (busy-double-start)
[554.562029] Starting subtest: busy-double-start
[554.563019] Starting dynamic subtest: rcs0
[558.167667] Dynamic subtest rcs0: FAIL (3.586s)
[558.174822] Starting dynamic subtest: bcs0
[561.765913] Dynamic subtest bcs0: SUCCESS (3.617s)
[561.777890] Starting dynamic subtest: vcs0
[565.877497] Dynamic subtest vcs0: SUCCESS (4.110s)
[565.888580] Starting dynamic subtest: vcs1
[569.842637] Dynamic subtest vcs1: SUCCESS (3.964s)
[569.853262] Starting dynamic subtest: vecs0
[573.920942] Dynamic subtest vecs0: SUCCESS (4.076s)
[573.932455] Starting dynamic subtest: ccs0
[577.514879] Dynamic subtest ccs0: FAIL (3.568s)
[577.515783] Subtest busy-double-start: FAIL (22.933s)
[577.641391] 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.