[61.870786] Initializing watchdogs
[61.870833]   /dev/watchdog0
[61.884142] [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]
[61.888452] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.890603] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.893988] [001/133] (960s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[62.045553] Starting subtest: basic-flip-after-cursor-legacy
[63.050446] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.002s)
[63.910907] [002/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[64.011333] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[70.831671] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.811s)
[70.961090] [003/133] (951s left) gem_exec_schedule (u-fairslice-all)
[71.040266] Starting subtest: u-fairslice-all
[73.104428] Subtest u-fairslice-all: SUCCESS (2.065s)
[73.403236] [004/133] (949s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[73.501797] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[73.504190] Starting dynamic subtest: pipe-A
[73.862547] Dynamic subtest pipe-A: SUCCESS (0.362s)
[73.869844] Starting dynamic subtest: pipe-B
[75.357215] Dynamic subtest pipe-B: SUCCESS (1.493s)
[75.366094] Starting dynamic subtest: pipe-C
[76.753993] Dynamic subtest pipe-C: SUCCESS (1.396s)
[76.763063] Starting dynamic subtest: pipe-D
[78.214981] Dynamic subtest pipe-D: SUCCESS (1.460s)
[78.217477] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.712s)
[79.350512] [005/133] (943s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[79.471063] Starting subtest: cursor-vs-flip-varying-size
[110.368196] Subtest cursor-vs-flip-varying-size: SUCCESS (30.885s)
[111.186566] [006/133] (911s left) kms_cursor_crc (cursor-sliding-256x256)
[111.424906] Starting subtest: cursor-sliding-256x256
[111.430115] Starting dynamic subtest: pipe-A-eDP-1
[114.665812] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.236s)
[114.696485] Starting dynamic subtest: pipe-D-eDP-1
[118.585771] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.896s)
[118.587819] Subtest cursor-sliding-256x256: SUCCESS (7.157s)
[119.458210] [007/133] (903s left) gem_ctx_engines (execute-one)
[119.533146] Starting subtest: execute-one
[122.017027] Subtest execute-one: SUCCESS (2.484s)
[122.199566] [008/133] (900s left) gem_ringfill (basic-all)
[127.896898] Starting subtest: basic-all
[129.080113] Subtest basic-all: SUCCESS (1.183s)
[129.229746] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[129.232817] [009/133] (893s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[129.335411] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[129.339694] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[129.420273] [010/133] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[129.514165] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[129.518120] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[129.619141] [011/133] (893s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[129.701931] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[129.704256] Starting dynamic subtest: pipe-A-eDP-1
[129.728621] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[129.740394] Starting dynamic subtest: pipe-B-eDP-1
[129.763658] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[129.774072] Starting dynamic subtest: pipe-C-eDP-1
[129.797469] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[129.805162] Starting dynamic subtest: pipe-D-eDP-1
[129.830143] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[129.834233] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[131.902733] [012/133] (890s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[132.012634] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[138.774480] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.766s)
[138.885267] [013/133] (883s left) gen9_exec_parse (allowed-single)
[138.960085] Subtest allowed-single: SKIP (0.000s)
[139.031899] [014/133] (883s left) gem_basic (multigpu-create-close)
[139.093083] Starting subtest: multigpu-create-close
[139.097668] Subtest multigpu-create-close: SKIP (0.000s)
[139.200641] [015/133] (883s left) syncobj_timeline (wait-all-interrupted)
[139.268018] Starting subtest: wait-all-interrupted
[139.369752] Subtest wait-all-interrupted: SUCCESS (0.102s)
[139.442870] [016/133] (883s left) perf_pmu (busy-no-semaphores)
[139.489017] Starting subtest: busy-no-semaphores
[139.491439] Starting dynamic subtest: rcs0
[140.038437] Dynamic subtest rcs0: SUCCESS (0.550s)
[140.048647] Starting dynamic subtest: bcs0
[140.587453] Dynamic subtest bcs0: SUCCESS (0.547s)
[140.598803] Starting dynamic subtest: vcs0
[141.135869] Dynamic subtest vcs0: SUCCESS (0.547s)
[141.147711] Starting dynamic subtest: vcs1
[142.423869] Dynamic subtest vcs1: SUCCESS (1.286s)
[142.433908] Starting dynamic subtest: vecs0
[144.409709] Dynamic subtest vecs0: SUCCESS (1.984s)
[144.420415] Starting dynamic subtest: ccs0
[146.457890] Dynamic subtest ccs0: SUCCESS (2.047s)
[146.461629] Subtest busy-no-semaphores: SUCCESS (6.971s)
[146.591758] [017/133] (876s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[146.694708] Starting subtest: y-tiled-8bpp-rotate-270
[146.699131] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[146.786149] [018/133] (876s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[146.844755] Starting subtest: y-tiled-ccs-to-x-tiled
[146.849441] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[147.034195] [019/133] (876s left) gem_userptr_blits (huge-split)
[147.103659] Starting subtest: huge-split
[147.110509] Subtest huge-split: SUCCESS (0.007s)
[147.218611] [020/133] (875s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[147.318548] Starting subtest: async-flip-with-page-flip-events-tiled
[147.705932] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[150.505739] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[150.517602] Starting dynamic subtest: pipe-A-eDP-1-4
[152.680079] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[152.691332] Starting dynamic subtest: pipe-A-eDP-1-4
[154.689818] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[154.701906] Starting dynamic subtest: pipe-A-eDP-1-x
[156.879962] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[157.247099] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[160.036409] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.795s)
[160.045864] Starting dynamic subtest: pipe-B-eDP-1-4
[162.210816] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s)
[162.219233] Starting dynamic subtest: pipe-B-eDP-1-4
[164.220986] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[164.229635] Starting dynamic subtest: pipe-B-eDP-1-x
[166.399761] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s)
[166.763250] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[169.570604] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.813s)
[169.578981] Starting dynamic subtest: pipe-C-eDP-1-4
[171.745621] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[171.754573] Starting dynamic subtest: pipe-C-eDP-1-4
[173.755943] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.010s)
[173.764647] Starting dynamic subtest: pipe-C-eDP-1-x
[175.934503] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[176.297177] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[179.098958] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.809s)
[179.107669] Starting dynamic subtest: pipe-D-eDP-1-4
[181.262282] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[181.273485] Starting dynamic subtest: pipe-D-eDP-1-4
[183.272807] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[183.284056] Starting dynamic subtest: pipe-D-eDP-1-x
[185.473486] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.200s)
[185.475854] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.157s)
[186.683371] [021/133] (836s left) kms_plane_cursor (viewport)
[186.779089] Starting subtest: viewport
[186.783308] Starting dynamic subtest: pipe-A-eDP-1-size-64
[189.289471] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.511s)
[189.350486] Starting dynamic subtest: pipe-A-eDP-1-size-128
[191.813223] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.471s)
[191.873226] Starting dynamic subtest: pipe-A-eDP-1-size-256
[194.358891] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.493s)
[194.726674] Starting dynamic subtest: pipe-B-eDP-1-size-64
[197.938820] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.222s)
[197.997655] Starting dynamic subtest: pipe-B-eDP-1-size-128
[200.483825] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.493s)
[200.553732] Starting dynamic subtest: pipe-B-eDP-1-size-256
[203.052623] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.517s)
[203.415333] Starting dynamic subtest: pipe-C-eDP-1-size-64
[206.254400] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.848s)
[206.291852] Starting dynamic subtest: pipe-C-eDP-1-size-128
[208.432506] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[208.468719] Starting dynamic subtest: pipe-C-eDP-1-size-256
[210.565371] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.102s)
[210.904793] Starting dynamic subtest: pipe-D-eDP-1-size-64
[213.651098] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.760s)
[213.687451] Starting dynamic subtest: pipe-D-eDP-1-size-128
[215.761073] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.080s)
[215.798757] Starting dynamic subtest: pipe-D-eDP-1-size-256
[217.917656] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.124s)
[218.236418] Subtest viewport: SUCCESS (31.457s)
[219.055595] [022/133] (804s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[219.117057] Starting subtest: invalid-bsd2-flag-on-vebox
[219.119654] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[219.218850] [023/133] (804s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[219.309131] Starting subtest: 4-tiled-8bpp-rotate-270
[219.330273] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[219.454078] [024/133] (803s left) kms_big_fb (linear-32bpp-rotate-0)
[219.554371] Starting subtest: linear-32bpp-rotate-0
[221.111675] Subtest linear-32bpp-rotate-0: SUCCESS (1.556s)
[221.230147] [025/133] (802s left) gem_mmap (bad-size)
[221.277104] Subtest bad-size: SKIP (0.000s)
[221.346069] [026/133] (802s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[221.438651] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[221.440642] Starting dynamic subtest: pipe-A-default-mode
[222.597453] Dynamic subtest pipe-A-default-mode: SKIP (1.156s)
[222.601522] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.158s)
[222.741488] [027/133] (800s left) syncobj_timeline (invalid-wait-bad-flags)
[222.790980] Starting subtest: invalid-wait-bad-flags
[222.793291] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[222.895092] [028/133] (800s left) syncobj_timeline (multi-wait-all-signaled)
[222.949764] Starting subtest: multi-wait-all-signaled
[222.952085] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[223.069803] [029/133] (800s left) kms_lease (invalid-create-leases)
[223.178126] Starting subtest: invalid-create-leases
[223.182907] Subtest invalid-create-leases: SUCCESS (0.005s)
[223.298899] [030/133] (800s left) gem_linear_blits (normal)
[223.737293] Starting subtest: normal
[227.365890] Subtest normal: SUCCESS (3.627s)
[227.475831] [031/133] (796s left) gem_userptr_blits (unsync-unmap-cycles)
[227.583651] Subtest unsync-unmap-cycles: SKIP (0.000s)
[227.718172] [032/133] (795s left) gem_exec_reloc (basic-gtt-read-active)
[227.785611] Subtest basic-gtt-read-active: SKIP (0.000s)
[227.857201] [033/133] (795s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[227.956961] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[227.959295] Starting dynamic subtest: pipe-A-eDP-1
[227.981688] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[227.992254] Starting dynamic subtest: pipe-B-eDP-1
[228.013555] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[228.022668] Starting dynamic subtest: pipe-C-eDP-1
[228.044126] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[228.052662] Starting dynamic subtest: pipe-D-eDP-1
[228.074196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[228.078162] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[230.223300] [034/133] (793s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[230.283772] Starting subtest: single-wait-all-for-submit-unsubmitted
[230.386223] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[230.466458] [035/133] (793s left) kms_pm_rpm (modeset-lpsp)
[232.033431] Starting subtest: modeset-lpsp
[233.489769] Subtest modeset-lpsp: SUCCESS (1.459s)
[233.609183] [036/133] (790s left) kms_vrr (negative-basic)
[233.707300] Starting subtest: negative-basic
[233.714156] Starting dynamic subtest: pipe-A-eDP-1
[239.128219] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.412s)
[239.436989] Subtest negative-basic: SUCCESS (5.729s)
[240.301577] [037/133] (783s left) kms_flip (flip-vs-wf_vblank-interruptible)
[240.404054] Starting subtest: flip-vs-wf_vblank-interruptible
[240.406327] Starting dynamic subtest: A-eDP1
[242.333856] Dynamic subtest A-eDP1: SUCCESS (1.929s)
[242.345645] Starting dynamic subtest: B-eDP1
[244.265440] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[244.276549] Starting dynamic subtest: C-eDP1
[246.179749] Dynamic subtest C-eDP1: SUCCESS (1.913s)
[246.190823] Starting dynamic subtest: D-eDP1
[248.013653] Dynamic subtest D-eDP1: SUCCESS (1.833s)
[248.018492] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.614s)
[249.261281] [038/133] (774s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[249.364969] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[249.367428] Starting dynamic subtest: pipe-A-eDP-1
[249.453771] Dynamic subtest pipe-A-eDP-1: SKIP (0.093s)
[249.463091] Starting dynamic subtest: pipe-B-eDP-1
[250.622545] Dynamic subtest pipe-B-eDP-1: SKIP (1.166s)
[250.627097] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.261s)
[251.810314] [039/133] (772s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[251.906474] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[253.007527] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.100s)
[253.133735] [040/133] (770s left) gem_exec_fence (syncobj-timeline-export)
[253.748077] Starting subtest: syncobj-timeline-export
[253.753927] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[255.010720] [041/133] (769s left) kms_psr (fbc-psr-primary-mmap-gtt)
[255.108107] Starting subtest: fbc-psr-primary-mmap-gtt
[255.110330] Starting dynamic subtest: eDP-1
[255.114608] Dynamic subtest eDP-1: SKIP (0.000s)
[255.118802] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[255.180161] [042/133] (768s left) i915_hangman (gt-engine-hang)
[255.251573] Starting subtest: gt-engine-hang
[255.253713] Starting dynamic subtest: rcs0
[256.885671] Dynamic subtest rcs0: SUCCESS (1.633s)
[256.899700] Starting dynamic subtest: bcs0
[258.868073] Dynamic subtest bcs0: SUCCESS (1.979s)
[258.881759] Starting dynamic subtest: vcs0
[260.852483] Dynamic subtest vcs0: SUCCESS (1.981s)
[260.863651] Starting dynamic subtest: vcs1
[262.835995] Dynamic subtest vcs1: SUCCESS (1.979s)
[262.848022] Starting dynamic subtest: vecs0
[264.883435] Dynamic subtest vecs0: SUCCESS (2.045s)
[264.894921] Starting dynamic subtest: ccs0
[266.869490] Dynamic subtest ccs0: SUCCESS (1.982s)
[266.872747] Subtest gt-engine-hang: SUCCESS (11.618s)
[266.998191] [043/133] (757s left) gem_mmap_gtt (basic-read)
[267.047779] Subtest basic-read: SKIP (0.000s)
[267.105865] [044/133] (757s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[267.240365] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[267.244731] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[267.384090] [045/133] (756s left) gem_exec_whisper (basic-sync)
[267.459703] Starting subtest: basic-sync
[274.244222] Subtest basic-sync: SUCCESS (6.783s)
[274.438946] [046/133] (749s left) kms_psr (psr2-basic)
[274.533810] Starting subtest: psr2-basic
[274.536092] Starting dynamic subtest: eDP-1
[276.181307] Dynamic subtest eDP-1: SUCCESS (1.647s)
[276.183492] Subtest psr2-basic: SUCCESS (1.648s)
[276.974624] [047/133] (747s left) gem_pxp (create-regular-context-1)
[277.100874] Starting subtest: create-regular-context-1
[277.103402] Subtest create-regular-context-1: SUCCESS (0.002s)
[277.205995] [048/133] (747s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[277.308125] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[277.312472] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[277.404764] [049/133] (746s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[277.502275] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[277.504575] Starting dynamic subtest: pipe-A-eDP-1
[277.527370] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[277.538683] Starting dynamic subtest: pipe-B-eDP-1
[277.560495] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[277.571137] Starting dynamic subtest: pipe-C-eDP-1
[277.592679] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[277.601060] Starting dynamic subtest: pipe-D-eDP-1
[277.623847] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[277.628292] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[279.743267] [050/133] (744s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[279.843373] Starting subtest: 2x-absolute-wf_vblank-interruptible
[279.854894] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[279.931182] [051/133] (744s left) kms_fbcon_fbt (psr)
[279.990669] Starting subtest: psr
[287.265052] Subtest psr: SUCCESS (7.271s)
[287.346567] [052/133] (737s left) gem_exec_balancer (sliced)
[287.424191] Starting subtest: sliced
[287.428500] Subtest sliced: SKIP (0.000s)
[287.716853] [053/133] (736s left) perf_pmu (semaphore-wait-idle)
[287.766719] Starting subtest: semaphore-wait-idle
[287.769113] Starting dynamic subtest: rcs0
[288.281281] Dynamic subtest rcs0: SUCCESS (0.514s)
[288.293590] Starting dynamic subtest: bcs0
[288.796028] Dynamic subtest bcs0: SUCCESS (0.511s)
[288.807546] Starting dynamic subtest: vcs0
[289.309625] Dynamic subtest vcs0: SUCCESS (0.510s)
[289.321039] Starting dynamic subtest: vcs1
[289.823232] Dynamic subtest vcs1: SUCCESS (0.510s)
[289.834898] Starting dynamic subtest: vecs0
[290.336424] Dynamic subtest vecs0: SUCCESS (0.509s)
[290.348707] Starting dynamic subtest: ccs0
[290.851724] Dynamic subtest ccs0: SUCCESS (0.512s)
[290.854579] Subtest semaphore-wait-idle: SUCCESS (3.087s)
[292.011789] [054/133] (732s left) kms_content_protection (uevent)
[292.154729] Starting subtest: uevent
[292.159312] Subtest uevent: SKIP (0.000s)
[292.267928] [055/133] (732s left) gem_madvise (dontneed-before-pwrite)
[292.302447] Starting subtest: dontneed-before-pwrite
[292.320385] Subtest dontneed-before-pwrite: SKIP (0.014s)
[292.374723] [056/133] (732s left) i915_suspend (fence-restore-tiled2untiled)
[292.439259] Starting subtest: fence-restore-tiled2untiled
[292.443282] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[292.542517] [057/133] (732s left) gem_ctx_param (invalid-size-get)
[292.593039] Starting subtest: invalid-size-get
[292.595418] Subtest invalid-size-get: SUCCESS (0.001s)
[292.693468] [058/133] (732s left) kms_psr (fbc-pr-basic)
[292.786087] Starting subtest: fbc-pr-basic
[292.790185] Subtest fbc-pr-basic: SKIP (0.000s)
[292.870156] [059/133] (731s left) prime_vgem (fence-write-hang)
[292.940613] Subtest fence-write-hang: SKIP (0.000s)
[293.048507] [060/133] (731s left) gem_mmap_wc (coherency)
[293.106692] Subtest coherency: SKIP (0.000s)
[293.170899] [061/133] (731s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[293.273420] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[293.275210] Starting dynamic subtest: pipe-A-eDP-1
[293.293569] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[293.303868] Starting dynamic subtest: pipe-B-eDP-1
[293.321373] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[293.330050] Starting dynamic subtest: pipe-C-eDP-1
[293.347790] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[293.357358] Starting dynamic subtest: pipe-D-eDP-1
[293.377978] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[293.381791] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[295.471253] [062/133] (729s left) kms_getfb (getfb2-handle-not-fb)
[295.571956] Starting subtest: getfb2-handle-not-fb
[295.574234] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[295.660563] [063/133] (729s left) device_reset (unbind-cold-reset-rebind)
[295.710080] Starting subtest: unbind-cold-reset-rebind
[295.713951] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[295.785770] [064/133] (729s left) gem_spin_batch (legacy)
[295.851872] Starting subtest: legacy
[295.854188] Starting dynamic subtest: default
[299.091615] Dynamic subtest default: SUCCESS (3.236s)
[299.104814] Starting dynamic subtest: render
[302.326490] Dynamic subtest render: SUCCESS (3.232s)
[302.338903] Starting dynamic subtest: bsd
[305.566386] Dynamic subtest bsd: SUCCESS (3.236s)
[305.577451] Starting dynamic subtest: bsd1
[308.801931] Dynamic subtest bsd1: SUCCESS (3.232s)
[308.812627] Starting dynamic subtest: bsd2
[312.039679] Dynamic subtest bsd2: SUCCESS (3.233s)
[312.050011] Starting dynamic subtest: blt
[315.275650] Dynamic subtest blt: SUCCESS (3.234s)
[315.284351] Starting dynamic subtest: vebox
[318.513689] Dynamic subtest vebox: SUCCESS (3.235s)
[318.515973] Subtest legacy: SUCCESS (22.661s)
[318.960772] [065/133] (706s left) gem_exec_schedule (preempt-contexts)
[319.045532] Starting subtest: preempt-contexts
[319.047844] Starting dynamic subtest: rcs0
[319.122945] Dynamic subtest rcs0: SUCCESS (0.085s)
[319.132648] Starting dynamic subtest: bcs0
[319.195818] Dynamic subtest bcs0: SUCCESS (0.072s)
[319.205594] Starting dynamic subtest: vcs0
[319.254533] Dynamic subtest vcs0: SUCCESS (0.057s)
[319.263841] Starting dynamic subtest: vcs1
[319.313273] Dynamic subtest vcs1: SUCCESS (0.059s)
[319.328374] Starting dynamic subtest: vecs0
[319.379260] Dynamic subtest vecs0: SUCCESS (0.065s)
[319.389160] Starting dynamic subtest: ccs0
[319.476580] Dynamic subtest ccs0: SUCCESS (0.096s)
[319.478912] Subtest preempt-contexts: SUCCESS (0.439s)
[321.018226] [066/133] (704s left) kms_invalid_mode (bad-htotal)
[321.126023] Starting subtest: bad-htotal
[321.128129] Starting dynamic subtest: pipe-A-eDP-1
[321.421932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[321.431102] Starting dynamic subtest: pipe-B-eDP-1
[321.433234] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[321.441232] Starting dynamic subtest: pipe-C-eDP-1
[321.443481] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[321.451720] Starting dynamic subtest: pipe-D-eDP-1
[321.453900] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[321.456165] Subtest bad-htotal: SUCCESS (0.303s)
[322.220230] [067/133] (702s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[322.327036] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[322.331495] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[322.428505] [068/133] (702s left) kms_psr (psr-primary-blt)
[322.521043] Starting subtest: psr-primary-blt
[322.523256] Starting dynamic subtest: eDP-1
[324.230916] Dynamic subtest eDP-1: SUCCESS (1.710s)
[324.233254] Subtest psr-primary-blt: SUCCESS (1.712s)
[325.093777] [069/133] (700s left) kms_properties (colorop-properties-atomic)
[325.179070] Starting subtest: colorop-properties-atomic
[325.181405] Starting dynamic subtest: pipe-A-eDP-1
[325.543632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[325.555629] Starting dynamic subtest: pipe-B-eDP-1
[326.669220] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[326.680751] Starting dynamic subtest: pipe-C-eDP-1
[327.685523] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.014s)
[327.694965] Starting dynamic subtest: pipe-D-eDP-1
[328.718198] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.032s)
[328.720614] Subtest colorop-properties-atomic: SUCCESS (3.540s)
[329.516124] [070/133] (695s left) gem_sync (basic-many-each)
[329.595277] Starting subtest: basic-many-each
[331.874302] Subtest basic-many-each: SUCCESS (2.289s)
[332.065305] [071/133] (693s left) kms_feature_discovery (display-3x)
[332.171614] Starting subtest: display-3x
[332.176221] Subtest display-3x: SKIP (0.000s)
[332.240158] [072/133] (693s left) perf_pmu (interrupts-sync)
[332.279513] Starting subtest: interrupts-sync
[333.363865] Subtest interrupts-sync: SUCCESS (1.085s)
[333.476499] [073/133] (691s left) gem_ctx_param (non-root-set)
[333.537456] Starting subtest: non-root-set
[333.564747] Subtest non-root-set: SUCCESS (0.027s)
[333.664622] [074/133] (691s left) vgem_basic (bad-fence)
[333.707462] Starting subtest: bad-fence
[333.709642] Subtest bad-fence: SUCCESS (0.000s)
[333.773861] [075/133] (691s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[333.873794] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[333.877995] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[333.974340] [076/133] (691s left) kms_psr (fbc-psr2-cursor-blt)
[334.051926] Starting subtest: fbc-psr2-cursor-blt
[334.054205] Starting dynamic subtest: eDP-1
[334.058325] Dynamic subtest eDP-1: SKIP (0.000s)
[334.062565] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[334.123435] [077/133] (691s left) kms_cursor_crc (cursor-onscreen-32x10)
[334.276844] Starting subtest: cursor-onscreen-32x10
[334.325537] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[334.580459] [078/133] (690s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[334.680196] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[339.991892] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.314s)
[341.117324] [079/133] (684s left) gem_exec_schedule (fairslice)
[341.179494] Starting subtest: fairslice
[341.181397] Starting dynamic subtest: rcs0
[343.194624] Dynamic subtest rcs0: SUCCESS (2.021s)
[343.203059] Starting dynamic subtest: bcs0
[345.215355] Dynamic subtest bcs0: SUCCESS (2.018s)
[345.224052] Starting dynamic subtest: vcs0
[347.235528] Dynamic subtest vcs0: SUCCESS (2.019s)
[347.244653] Starting dynamic subtest: vcs1
[349.254615] Dynamic subtest vcs1: SUCCESS (2.019s)
[349.263502] Starting dynamic subtest: vecs0
[351.275288] Dynamic subtest vecs0: SUCCESS (2.021s)
[351.286570] Starting dynamic subtest: ccs0
[353.302205] Dynamic subtest ccs0: SUCCESS (2.025s)
[353.304062] Subtest fairslice: SUCCESS (12.129s)
[353.601986] [080/133] (671s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[353.696711] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[353.700824] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[353.814475] [081/133] (671s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[353.927044] Starting subtest: flip-vs-cursor-crc-legacy
[354.585114] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.655s)
[355.440082] [082/133] (670s left) gem_ctx_shared (q-smoketest)
[355.500909] Starting subtest: Q-smoketest
[355.503358] Starting dynamic subtest: rcs0
[361.080673] Dynamic subtest rcs0: SUCCESS (5.534s)
[361.090968] Starting dynamic subtest: bcs0
[366.561634] Dynamic subtest bcs0: SUCCESS (5.476s)
[366.575596] Starting dynamic subtest: vcs0
[372.058970] Dynamic subtest vcs0: SUCCESS (5.485s)
[372.074309] Starting dynamic subtest: vcs1
[377.529633] Dynamic subtest vcs1: SUCCESS (5.477s)
[377.543522] Starting dynamic subtest: vecs0
[382.998953] Dynamic subtest vecs0: SUCCESS (5.469s)
[383.010983] Starting dynamic subtest: ccs0
[388.518132] Dynamic subtest ccs0: SUCCESS (5.518s)
[388.520151] Subtest Q-smoketest: SUCCESS (32.967s)
[388.667264] [083/133] (637s left) kms_chamelium_frames (hdmi-frame-dump)
[389.055875] Subtest hdmi-frame-dump: SKIP (0.000s)
[389.843165] [084/133] (635s left) gem_flink_race (flink_close)
[389.882316] Starting subtest: flink_close
[394.946811] Subtest flink_close: SUCCESS (5.064s)
[395.025451] [085/133] (630s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[395.137866] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[395.140192] Starting dynamic subtest: pipe-A-eDP-1
[395.160082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[395.169991] Starting dynamic subtest: pipe-B-eDP-1
[395.188659] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[395.197666] Starting dynamic subtest: pipe-C-eDP-1
[395.216671] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[395.225776] Starting dynamic subtest: pipe-D-eDP-1
[395.245066] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[395.246941] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[397.413784] [086/133] (628s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[397.502841] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[397.506979] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[397.586350] [087/133] (628s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[397.680803] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[404.780322] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.102s)
[404.883132] [088/133] (621s left) gem_pxp (reject-modify-context-protection-off-3)
[404.939872] Starting subtest: reject-modify-context-protection-off-3
[404.942250] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[405.036667] [089/133] (620s left) syncobj_eventfd (invalid-illegal-handle)
[405.107613] Starting subtest: invalid-illegal-handle
[405.110035] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[405.220346] [090/133] (620s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[405.310064] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[405.312218] Starting dynamic subtest: pipe-A-eDP-1
[405.334558] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[405.346259] Starting dynamic subtest: pipe-B-eDP-1
[405.366989] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[405.375414] Starting dynamic subtest: pipe-C-eDP-1
[405.396285] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[405.404831] Starting dynamic subtest: pipe-D-eDP-1
[405.427578] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[405.431940] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[407.505438] [091/133] (618s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[407.603606] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[407.607959] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[407.714605] [092/133] (618s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[407.814349] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[412.369545] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.559s)
[413.498826] [093/133] (612s left) gem_mmap_gtt (big-bo-tiledy)
[413.571616] Subtest big-bo-tiledY: SKIP (0.000s)
[413.641253] [094/133] (612s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[413.740032] Starting subtest: bo-too-small-due-to-tiling
[413.744450] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[413.821767] [095/133] (612s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[413.925879] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[425.107886] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.182s)
[425.920444] [096/133] (600s left) api_intel_bb (object-noreloc-purge-cache-simple)
[425.977105] Starting subtest: object-noreloc-purge-cache-simple
[425.981896] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s)
[426.104924] [097/133] (600s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[426.169447] Subtest untiled-to-tiled: SKIP (0.000s)
[426.232633] [098/133] (600s left) gem_ctx_persistence (file)
[426.280276] Starting subtest: file
[426.390441] Subtest file: SUCCESS (0.110s)
[426.498422] [099/133] (599s left) kms_plane (pixel-format-linear-modifier)
[426.588381] Starting subtest: pixel-format-linear-modifier
[426.614619] Starting dynamic subtest: pipe-A-plane-0
[430.147426] Dynamic subtest pipe-A-plane-0: SUCCESS (3.533s)
[430.156832] Starting dynamic subtest: pipe-A-plane-3
[431.858633] Dynamic subtest pipe-A-plane-3: SUCCESS (1.710s)
[431.868146] Starting dynamic subtest: pipe-A-plane-5
[432.092308] Dynamic subtest pipe-A-plane-5: SUCCESS (0.233s)
[433.214339] Starting dynamic subtest: pipe-B-plane-0
[436.850916] Dynamic subtest pipe-B-plane-0: SUCCESS (3.644s)
[436.859577] Starting dynamic subtest: pipe-B-plane-3
[438.506763] Dynamic subtest pipe-B-plane-3: SUCCESS (1.655s)
[438.516771] Starting dynamic subtest: pipe-B-plane-5
[438.717812] Dynamic subtest pipe-B-plane-5: SUCCESS (0.209s)
[439.043062] Subtest pixel-format-linear-modifier: SUCCESS (12.456s)
[439.892393] [100/133] (586s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[440.241068] Starting subtest: cursor-rapid-movement-max-size
[440.247653] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[440.379880] [101/133] (586s left) kms_pipe_crc_basic (hang-read-crc)
[440.474053] Starting subtest: hang-read-crc
[440.476407] Starting dynamic subtest: pipe-A-eDP-1
[442.563218] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.086s)
[442.573120] Starting dynamic subtest: pipe-B-eDP-1
[445.236024] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.671s)
[445.244672] Starting dynamic subtest: pipe-C-eDP-1
[447.852439] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.616s)
[447.862672] Starting dynamic subtest: pipe-D-eDP-1
[450.512932] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.661s)
[450.515280] Subtest hang-read-crc: SUCCESS (10.040s)
[451.344816] [102/133] (575s left) gem_mmap_offset (clear-via-pagefault)
[451.400497] Starting subtest: clear-via-pagefault
[451.402409] Starting dynamic subtest: smem0
[483.807952] Dynamic subtest smem0: SUCCESS (32.402s)
[483.809961] Subtest clear-via-pagefault: SUCCESS (32.403s)
[483.918416] [103/133] (542s left) i915_pm_rps (min-max-config-loaded)
[483.983958] Starting subtest: min-max-config-loaded
[483.988632] Subtest min-max-config-loaded: SKIP (0.002s)
[484.061854] [104/133] (542s left) gem_exec_flush (basic-batch-kernel-default-uc)
[484.118670] Starting subtest: basic-batch-kernel-default-uc
[490.975917] Subtest basic-batch-kernel-default-uc: SUCCESS (6.857s)
[491.163524] [105/133] (535s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[491.229592] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[491.232073] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[491.358473] [106/133] (535s left) kms_vblank (wait-forked)
[491.451081] Starting subtest: wait-forked
[491.453137] Starting dynamic subtest: pipe-A-eDP-1
[493.257307] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s)
[493.272460] Starting dynamic subtest: pipe-D-eDP-1
[495.745842] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.484s)
[495.748502] Subtest wait-forked: SUCCESS (4.296s)
[496.603852] [107/133] (530s left) gem_exec_flush (basic-wb-rw-before-default)
[496.660773] Starting subtest: basic-wb-rw-before-default
[502.110758] Subtest basic-wb-rw-before-default: SUCCESS (5.452s)
[502.298668] [108/133] (524s left) kms_plane_scaling (planes-scaler-unity-scaling)
[502.391770] Starting subtest: planes-scaler-unity-scaling
[502.394065] Starting dynamic subtest: pipe-A
[502.453724] Dynamic subtest pipe-A: SUCCESS (0.064s)
[502.463411] Starting dynamic subtest: pipe-B
[503.624363] Dynamic subtest pipe-B: SUCCESS (1.169s)
[503.634062] Starting dynamic subtest: pipe-C
[504.749824] Dynamic subtest pipe-C: SUCCESS (1.122s)
[504.759820] Starting dynamic subtest: pipe-D
[505.869745] Dynamic subtest pipe-D: SUCCESS (1.122s)
[505.872062] Subtest planes-scaler-unity-scaling: SUCCESS (3.480s)
[507.034817] [109/133] (519s left) kms_psr (psr-cursor-plane-move)
[507.128248] Starting subtest: psr-cursor-plane-move
[507.130681] Starting dynamic subtest: eDP-1
[508.821725] Dynamic subtest eDP-1: SUCCESS (1.692s)
[508.824028] Subtest psr-cursor-plane-move: SUCCESS (1.693s)
[509.687406] [110/133] (517s left) gem_madvise (dontneed-before-exec)
[509.721126] Starting subtest: dontneed-before-exec
[509.735054] Subtest dontneed-before-exec: SKIP (0.014s)
[509.799834] [111/133] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[509.897315] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[509.901604] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[509.981895] [112/133] (516s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[510.069220] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[510.080577] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[510.162874] [113/133] (516s left) syncobj_basic (bad-pad-handle-to-fd)
[510.213056] Starting subtest: bad-pad-handle-to-fd
[510.215296] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[510.312854] [114/133] (516s left) gem_userptr_blits (sync-unmap-cycles)
[510.386018] Starting subtest: sync-unmap-cycles
[515.761490] Subtest sync-unmap-cycles: SUCCESS (5.375s)
[515.905313] [115/133] (511s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[516.003911] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[516.007545] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[516.123926] [116/133] (510s left) kms_async_flips (test-time-stamp)
[516.212154] Starting subtest: test-time-stamp
[516.596392] Starting dynamic subtest: pipe-A-eDP-1
[517.392495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s)
[517.770564] Starting dynamic subtest: pipe-B-eDP-1
[518.515162] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.750s)
[518.890314] Starting dynamic subtest: pipe-C-eDP-1
[519.653627] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[520.021896] Starting dynamic subtest: pipe-D-eDP-1
[520.781406] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[520.784027] Subtest test-time-stamp: SUCCESS (4.568s)
[521.940473] [117/133] (505s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[522.043946] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[522.048260] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[522.133500] [118/133] (505s left) kms_addfb_basic (bad-pitch-1024)
[522.194235] Starting subtest: bad-pitch-1024
[522.196068] Subtest bad-pitch-1024: SUCCESS (0.000s)
[522.340421] [119/133] (504s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[522.444468] Starting subtest: plane-lut1d-post-ctm3x4
[522.635072] Starting dynamic subtest: pipe-A-plane-0
[522.982440] Dynamic subtest pipe-A-plane-0: FAIL (0.204s)
[522.995485] Starting dynamic subtest: pipe-A-plane-1
[523.199061] Dynamic subtest pipe-A-plane-1: FAIL (0.181s)
[523.209564] Starting dynamic subtest: pipe-A-plane-2
[523.414947] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[524.323288] Starting dynamic subtest: pipe-B-plane-0
[524.737461] Dynamic subtest pipe-B-plane-0: FAIL (0.141s)
[524.748393] Starting dynamic subtest: pipe-B-plane-1
[525.062305] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[525.072438] Starting dynamic subtest: pipe-B-plane-2
[525.368891] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[525.964866] Starting dynamic subtest: pipe-C-plane-0
[526.456702] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[526.467889] Starting dynamic subtest: pipe-C-plane-1
[526.871902] Dynamic subtest pipe-C-plane-1: FAIL (0.610s)
[526.883236] Starting dynamic subtest: pipe-C-plane-2
[527.246476] Dynamic subtest pipe-C-plane-2: FAIL (0.159s)
[528.096221] Starting dynamic subtest: pipe-D-plane-0
[528.683967] Dynamic subtest pipe-D-plane-0: FAIL (0.129s)
[528.694934] Starting dynamic subtest: pipe-D-plane-1
[529.155752] Dynamic subtest pipe-D-plane-1: FAIL (0.623s)
[529.166588] Starting dynamic subtest: pipe-D-plane-2
[529.606898] Dynamic subtest pipe-D-plane-2: FAIL (0.557s)
[529.688619] Subtest plane-lut1d-post-ctm3x4: FAIL (7.245s)
[530.569029] [120/133] (496s left) perf (short-reads)
[530.707284] Starting subtest: short-reads
[530.720253] Subtest short-reads: SUCCESS (0.016s)
[530.770507] [121/133] (496s left) gem_ctx_param (invalid-get-no-zeromap)
[530.820789] Starting subtest: invalid-get-no-zeromap
[530.823775] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[530.937747] [122/133] (496s left) gem_exec_reloc (basic-wc-cpu-active)
[530.990071] Subtest basic-wc-cpu-active: SKIP (0.000s)
[531.056284] [123/133] (496s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[531.440800] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[532.282614] [124/133] (495s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[532.374399] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[532.378423] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[532.477805] [125/133] (494s left) i915_drm_fdinfo (busy)
[532.525407] Starting subtest: busy
[532.527608] Starting dynamic subtest: rcs0
[532.546625] Dynamic subtest rcs0: SKIP (0.019s)
[532.556566] Starting dynamic subtest: bcs0
[532.560740] Dynamic subtest bcs0: SKIP (0.000s)
[532.569431] Starting dynamic subtest: vcs0
[532.573376] Dynamic subtest vcs0: SKIP (0.001s)
[532.581934] Starting dynamic subtest: vcs1
[532.586112] Dynamic subtest vcs1: SKIP (0.000s)
[532.594589] Starting dynamic subtest: vecs0
[532.598764] Dynamic subtest vecs0: SKIP (0.000s)
[532.607256] Starting dynamic subtest: ccs0
[532.611453] Dynamic subtest ccs0: SKIP (0.000s)
[532.615704] Subtest busy: SKIP (0.027s)
[532.652582] [126/133] (494s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[532.737233] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[532.739430] Starting dynamic subtest: pipe-A-default-mode
[535.469189] Dynamic subtest pipe-A-default-mode: SUCCESS (2.729s)
[535.471446] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.731s)
[536.306402] [127/133] (491s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[536.403663] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[543.441095] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.040s)
[543.571866] [128/133] (484s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[543.682652] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[547.660727] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.981s)
[548.809760] [129/133] (478s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[548.921389] Starting subtest: primary-yf-tiled-reflect-x-270
[548.925578] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[548.994515] [130/133] (478s left) kms_vblank (accuracy-idle)
[549.089171] Starting subtest: accuracy-idle
[549.091070] Starting dynamic subtest: pipe-A-eDP-1
[550.858428] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.770s)
[550.874440] Starting dynamic subtest: pipe-D-eDP-1
[553.262735] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.400s)
[553.264989] Subtest accuracy-idle: SUCCESS (4.174s)
[554.089222] [131/133] (473s left) gem_exec_whisper (basic-normal-all)
[554.148523] Starting subtest: basic-normal-all
[556.889048] Subtest basic-normal-all: SUCCESS (2.738s)
[557.073230] [132/133] (470s left) gem_exec_balancer (individual)
[557.140265] Starting subtest: individual
[558.941067] Subtest individual: SUCCESS (1.799s)
[559.255377] [133/133] (468s left) kms_pm_dc (dc5-dpms)
[560.350780] Starting subtest: dc5-dpms
[562.449178] Subtest dc5-dpms: SUCCESS (2.098s)
[562.535516] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: kms_cursor_legacy
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: gem_ctx_engines
results: parsing output: 7/ for test: gem_ringfill
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: gem_basic
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: kms_plane_cursor
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_mmap
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: gem_linear_blits
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: kms_pm_rpm
results: parsing output: 35/ for test: kms_vrr
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_exec_fence
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: i915_hangman
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: gem_exec_whisper
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_pxp
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_fbcon_fbt
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: gem_madvise
results: parsing output: 55/ for test: i915_suspend
results: parsing output: 56/ for test: gem_ctx_param
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: gem_mmap_wc
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_getfb
results: parsing output: 62/ for test: device_reset
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_invalid_mode
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_properties
results: parsing output: 69/ for test: gem_sync
results: parsing output: 70/ for test: kms_feature_discovery
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: vgem_basic
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_ctx_shared
results: parsing output: 82/ for test: kms_chamelium_frames
results: parsing output: 83/ for test: gem_flink_race
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_pxp
results: parsing output: 88/ for test: syncobj_eventfd
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_mmap_gtt
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: gem_set_tiling_vs_blt
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_pipe_crc_basic
results: parsing output: 101/ for test: gem_mmap_offset
results: parsing output: 102/ for test: i915_pm_rps
results: parsing output: 103/ for test: gem_exec_flush
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: gem_exec_flush
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_madvise
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: syncobj_basic
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_async_flips
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_color_pipeline
results: parsing output: 119/ for test: perf
results: parsing output: 120/ for test: gem_ctx_param
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_chamelium_hpd
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: i915_drm_fdinfo
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: gem_exec_whisper
results: parsing output: 131/ for test: gem_exec_balancer
results: parsing output: 132/ for test: kms_pm_dc
Done.