[59.500356] Initializing watchdogs
[59.500403]   /dev/watchdog0
[59.514480] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.518715] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.520702] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.522440] [001/132] (960s left) gem_exec_schedule (independent)
[59.588884] Starting subtest: independent
[59.589881] Starting dynamic subtest: rcs0
[60.890037] Dynamic subtest rcs0: SUCCESS (1.298s)
[60.898198] Starting dynamic subtest: vcs0
[62.960248] Dynamic subtest vcs0: SUCCESS (2.069s)
[62.968213] Starting dynamic subtest: vcs1
[64.932988] Dynamic subtest vcs1: SUCCESS (1.972s)
[64.939020] Starting dynamic subtest: vecs0
[67.491487] Dynamic subtest vecs0: SUCCESS (2.557s)
[67.500442] Starting dynamic subtest: ccs0
[68.889812] Dynamic subtest ccs0: SUCCESS (1.397s)
[68.891530] Subtest independent: SUCCESS (9.299s)
[69.204202] [002/132] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[69.303054] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[69.304819] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[69.410023] [003/132] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[69.507982] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[69.509781] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[69.620241] [004/132] (950s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[69.675176] Starting subtest: invalid-signal-one-illegal-handle
[69.676106] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[69.788162] [005/132] (950s left) gem_softpin (32b-excludes-last-page)
[69.839906] Starting subtest: 32b-excludes-last-page
[69.843980] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[69.998204] [006/132] (950s left) gem_mmap_gtt (basic-copy)
[70.051092] Subtest basic-copy: SKIP (0.000s)
[70.109892] [007/132] (950s left) kms_content_protection (atomic-dpms-hdcp14)
[70.251604] Starting subtest: atomic-dpms-hdcp14
[70.253440] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[70.397361] [008/132] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[70.497563] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[77.349274] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.850s)
[77.545420] [009/132] (942s left) gem_mmap_gtt (coherency)
[77.597631] Subtest coherency: SKIP (0.000s)
[77.648068] [010/132] (942s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[77.745131] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[77.750762] Starting dynamic subtest: pipe-A-default-mode
[80.442931] Dynamic subtest pipe-A-default-mode: SUCCESS (2.697s)
[80.443910] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.698s)
[81.295546] [011/132] (939s left) kms_cursor_crc (cursor-offscreen-512x170)
[81.562161] Starting subtest: cursor-offscreen-512x170
[81.564134] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[81.747016] [012/132] (938s left) perf_pmu (busy-double-start)
[81.780895] Starting subtest: busy-double-start
[81.781909] Starting dynamic subtest: rcs0
[85.375454] Dynamic subtest rcs0: FAIL (3.575s)
[85.381940] Starting dynamic subtest: bcs0
[88.930620] Dynamic subtest bcs0: SUCCESS (3.574s)
[88.939262] Starting dynamic subtest: vcs0
[93.437888] Dynamic subtest vcs0: SUCCESS (4.506s)
[93.446617] Starting dynamic subtest: vcs1
[97.436714] Dynamic subtest vcs1: SUCCESS (3.998s)
[97.444614] Starting dynamic subtest: vecs0
[101.451858] Dynamic subtest vecs0: SUCCESS (4.014s)
[101.460317] Starting dynamic subtest: ccs0
[105.043028] Dynamic subtest ccs0: FAIL (3.568s)
[105.043883] Subtest busy-double-start: FAIL (23.240s)
[105.160828] [013/132] (915s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[105.280096] Starting subtest: fbc-rgb565-draw-pwrite
[109.867711] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.589s)
[111.085213] [014/132] (909s left) gem_tiled_pread_basic
[111.198935] [015/132] (909s left) kms_psr (fbc-psr2-cursor-plane-move)
[111.293226] Starting subtest: fbc-psr2-cursor-plane-move
[111.294459] Starting dynamic subtest: eDP-1
[111.296346] Dynamic subtest eDP-1: SKIP (0.000s)
[111.298181] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[111.379919] [016/132] (909s left) gem_render_copy (y-tiled-ccs-to-linear)
[111.444141] Starting subtest: y-tiled-ccs-to-linear
[111.445990] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[111.647064] [017/132] (908s left) kms_color (ctm-0-25)
[111.744937] Starting subtest: ctm-0-25
[111.745777] Starting dynamic subtest: pipe-A-eDP-1
[115.123788] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.379s)
[115.130866] Starting dynamic subtest: pipe-B-eDP-1
[119.225394] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.100s)
[119.232156] Starting dynamic subtest: pipe-C-eDP-1
[123.173877] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.949s)
[123.180987] Starting dynamic subtest: pipe-D-eDP-1
[127.178238] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.003s)
[127.179213] Subtest ctm-0-25: SUCCESS (15.433s)
[128.043304] [018/132] (892s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[128.610361] Starting subtest: syncobj-timeline-multiple-ext-nodes
[128.611680] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[130.016695] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[130.018581] [019/132] (890s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[130.109214] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[130.120934] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[130.213816] [020/132] (890s left) gem_mmap_gtt (fault-concurrent-y)
[130.265373] Subtest fault-concurrent-Y: SKIP (0.000s)
[130.314995] [021/132] (890s left) syncobj_timeline (reset-signaled)
[130.366236] Starting subtest: reset-signaled
[130.367260] Subtest reset-signaled: SUCCESS (0.000s)
[130.496684] [022/132] (890s left) kms_lease (simple-lease)
[130.585359] Starting subtest: simple-lease
[130.586326] Starting dynamic subtest: pipe-A-eDP-1
[131.107348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.521s)
[131.119738] Starting dynamic subtest: pipe-B-eDP-1
[132.575945] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.468s)
[132.583394] Starting dynamic subtest: pipe-C-eDP-1
[133.969175] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s)
[133.975480] Starting dynamic subtest: pipe-D-eDP-1
[135.351367] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.380s)
[135.352686] Subtest simple-lease: SUCCESS (4.766s)
[136.173644] [023/132] (884s left) gem_exec_whisper (basic-queues-priority-all)
[136.239357] Starting subtest: basic-queues-priority-all
[158.140703] Subtest basic-queues-priority-all: SUCCESS (21.896s)
[158.339414] [024/132] (862s left) gem_exec_balancer (parallel-ordering)
[158.602441] Starting subtest: parallel-ordering
[159.543907] Subtest parallel-ordering: SUCCESS (0.941s)
[159.706053] [025/132] (861s left) gem_fenced_exec_thrash (too-many-fences)
[159.756239] Subtest too-many-fences: SKIP (0.000s)
[159.831343] [026/132] (860s left) kms_chamelium_frames (dp-crc-single)
[160.228054] Subtest dp-crc-single: SKIP (0.000s)
[161.063065] [027/132] (859s left) kms_big_fb (linear-16bpp-rotate-90)
[161.164052] Starting subtest: linear-16bpp-rotate-90
[161.183416] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[161.325424] [028/132] (859s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[161.435115] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[161.436942] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[161.582892] [029/132] (859s left) api_intel_bb (crc32)
[161.631499] Starting subtest: crc32
[161.632556] Starting dynamic subtest: rcs0-smem0
[161.928473] Dynamic subtest rcs0-smem0: SUCCESS (0.295s)
[161.938084] Starting dynamic subtest: bcs0-smem0
[162.281431] Dynamic subtest bcs0-smem0: SUCCESS (0.351s)
[162.291538] Starting dynamic subtest: vcs0-smem0
[162.607360] Dynamic subtest vcs0-smem0: SUCCESS (0.324s)
[162.617059] Starting dynamic subtest: vcs1-smem0
[162.939417] Dynamic subtest vcs1-smem0: SUCCESS (0.331s)
[162.948273] Starting dynamic subtest: vecs0-smem0
[163.297771] Dynamic subtest vecs0-smem0: SUCCESS (0.356s)
[163.307676] Starting dynamic subtest: ccs0-smem0
[163.621043] Dynamic subtest ccs0-smem0: SUCCESS (0.321s)
[163.622591] Subtest crc32: SUCCESS (1.989s)
[163.782623] [030/132] (857s left) kms_psr (fbc-pr-sprite-plane-onoff)
[163.874226] Starting subtest: fbc-pr-sprite-plane-onoff
[163.875846] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[163.962662] [031/132] (856s left) gem_eio (wait-1us)
[164.174775] Starting subtest: wait-1us
[164.503914] Subtest wait-1us: SUCCESS (0.330s)
[164.675094] [032/132] (856s left) kms_feature_discovery (chamelium)
[164.760405] Starting subtest: chamelium
[164.762093] Subtest chamelium: SKIP (0.000s)
[164.852993] [033/132] (856s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[164.946588] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[164.948359] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[165.086208] [034/132] (855s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[165.164547] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[165.166931] Starting dynamic subtest: A-eDP1
[168.838426] Dynamic subtest A-eDP1: SUCCESS (3.672s)
[168.845919] Starting dynamic subtest: B-eDP1
[172.036806] Dynamic subtest B-eDP1: SUCCESS (3.197s)
[172.044086] Starting dynamic subtest: C-eDP1
[175.154159] Dynamic subtest C-eDP1: SUCCESS (3.117s)
[175.161149] Starting dynamic subtest: D-eDP1
[178.266741] Dynamic subtest D-eDP1: SUCCESS (3.112s)
[178.269303] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.103s)
[179.089842] [035/132] (842s left) i915_pciid
[179.273617] [036/132] (841s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[179.362947] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[179.363952] Starting dynamic subtest: pipe-A
[179.701572] Dynamic subtest pipe-A: SUCCESS (0.340s)
[179.710986] Starting dynamic subtest: pipe-B
[181.073526] Dynamic subtest pipe-B: SUCCESS (1.371s)
[181.088147] Starting dynamic subtest: pipe-C
[182.519829] Dynamic subtest pipe-C: SUCCESS (1.444s)
[182.532387] Starting dynamic subtest: pipe-D
[183.943483] Dynamic subtest pipe-D: SUCCESS (1.423s)
[183.944350] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.583s)
[185.135119] [037/132] (836s left) gem_exec_flush (basic-wb-ro-before-default)
[185.207972] Starting subtest: basic-wb-ro-before-default
[190.668590] Subtest basic-wb-ro-before-default: SUCCESS (5.456s)
[190.870605] [038/132] (830s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[190.973997] Starting subtest: 4-tiled-8bpp-rotate-180
[192.110299] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.137s)
[192.276358] [039/132] (828s left) kms_pipe_stress (stress-xrgb8888-untiled)
[192.371692] Starting subtest: stress-xrgb8888-untiled
[198.296987] Subtest stress-xrgb8888-untiled: SUCCESS (5.925s)
[198.340804] [040/132] (822s left) gem_exec_reloc (basic-cpu-wc-active)
[198.407119] Subtest basic-cpu-wc-active: SKIP (0.000s)
[198.482521] [041/132] (822s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[198.606066] Starting subtest: verify-pxp-key-change-after-suspend-resume
[209.604843] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (10.999s)
[215.758615] [042/132] (811s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[215.884359] Starting subtest: primary-yf-tiled-reflect-x-90
[215.886156] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[215.958644] [043/132] (811s left) api_intel_bb (blit-noreloc-keep-cache)
[216.007153] Starting subtest: blit-noreloc-keep-cache
[216.016207] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[216.156430] [044/132] (811s left) kms_pm_backlight (fade-with-suspend)
[216.247322] Starting subtest: fade-with-suspend
[233.112270] Starting dynamic subtest: eDP-1
[235.783183] Dynamic subtest eDP-1: SUCCESS (2.691s)
[235.783977] Subtest fade-with-suspend: SUCCESS (4.351s)
[241.605165] [045/132] (790s left) kms_addfb_basic (small-bo)
[241.711813] Starting subtest: small-bo
[241.712712] Subtest small-bo: SUCCESS (0.000s)
[241.824520] [046/132] (790s left) gem_userptr_blits (mmap-offset-banned)
[241.898472] Starting subtest: mmap-offset-banned
[241.899446] Starting dynamic subtest: wb
[241.900420] Dynamic subtest wb: SUCCESS (0.000s)
[241.909676] Starting dynamic subtest: wc
[241.910596] Dynamic subtest wc: SUCCESS (0.000s)
[241.917972] Starting dynamic subtest: uc
[241.918912] Dynamic subtest uc: SUCCESS (0.000s)
[241.919851] Subtest mmap-offset-banned: SUCCESS (0.002s)
[242.071141] [047/132] (790s left) kms_invalid_mode (zero-vdisplay)
[242.165130] Starting subtest: zero-vdisplay
[242.166044] Starting dynamic subtest: pipe-A-eDP-1
[242.447401] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[242.454896] Starting dynamic subtest: pipe-B-eDP-1
[242.455670] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[242.462598] Starting dynamic subtest: pipe-C-eDP-1
[242.463415] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[242.470461] Starting dynamic subtest: pipe-D-eDP-1
[242.471350] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[242.472212] Subtest zero-vdisplay: SUCCESS (0.287s)
[243.325947] [048/132] (789s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[243.424634] Starting subtest: psr-rgb101010-draw-pwrite
[251.007468] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.584s)
[251.128426] [049/132] (781s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[251.217867] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[251.218665] Starting dynamic subtest: pipe-A-eDP-1
[251.239204] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[251.246993] Starting dynamic subtest: pipe-B-eDP-1
[251.267488] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[251.274906] Starting dynamic subtest: pipe-C-eDP-1
[251.295312] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[251.303150] Starting dynamic subtest: pipe-D-eDP-1
[251.324733] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[251.326470] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[253.399702] [050/132] (779s left) kms_cursor_crc (cursor-sliding-max-size)
[253.704177] Starting subtest: cursor-sliding-max-size
[253.707001] Subtest cursor-sliding-max-size: SKIP (0.000s)
[253.877834] [051/132] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[253.978872] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[253.980550] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[254.113500] [052/132] (778s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[254.159127] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[254.270148] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[254.362744] [053/132] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[254.459385] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[254.461207] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[254.607223] [054/132] (778s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[254.697078] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[254.697937] Starting dynamic subtest: pipe-A-eDP-1
[254.706482] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[254.714311] Starting dynamic subtest: pipe-B-eDP-1
[254.723023] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[254.730774] Starting dynamic subtest: pipe-C-eDP-1
[254.739157] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[254.746688] Starting dynamic subtest: pipe-D-eDP-1
[254.755341] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[254.756993] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[256.872405] [055/132] (775s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[256.980547] Starting subtest: x-tiled-16bpp-rotate-90
[257.002685] Subtest x-tiled-16bpp-rotate-90: SKIP (0.021s)
[257.144582] [056/132] (775s left) kms_plane (plane-panning-top-left)
[257.237877] Starting subtest: plane-panning-top-left
[257.238825] Starting dynamic subtest: pipe-A
[258.898116] Dynamic subtest pipe-A: SUCCESS (1.660s)
[258.908512] Starting dynamic subtest: pipe-B
[261.202643] Dynamic subtest pipe-B: SUCCESS (2.301s)
[261.203822] Subtest plane-panning-top-left: SUCCESS (3.965s)
[262.019982] [057/132] (770s left) kms_getfb (getfb-handle-zero)
[262.118425] Starting subtest: getfb-handle-zero
[262.119470] Subtest getfb-handle-zero: SUCCESS (0.000s)
[262.251044] [058/132] (770s left) kms_flip (dpms-vs-vblank-race-interruptible)
[262.350062] Starting subtest: dpms-vs-vblank-race-interruptible
[262.351574] Starting dynamic subtest: A-eDP1
[267.282974] Dynamic subtest A-eDP1: SUCCESS (4.931s)
[267.292247] Starting dynamic subtest: B-eDP1
[271.912604] Dynamic subtest B-eDP1: SUCCESS (4.628s)
[271.920307] Starting dynamic subtest: C-eDP1
[276.518785] Dynamic subtest C-eDP1: SUCCESS (4.605s)
[276.527683] Starting dynamic subtest: D-eDP1
[281.151957] Dynamic subtest D-eDP1: SUCCESS (4.631s)
[281.154012] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.805s)
[282.054845] [059/132] (750s left) kms_addfb_basic (bad-pitch-256)
[282.117497] Starting subtest: bad-pitch-256
[282.118440] Subtest bad-pitch-256: SUCCESS (0.000s)
[282.289131] [060/132] (750s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[282.373693] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[282.374602] Starting dynamic subtest: pipe-A-eDP-1
[283.196840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s)
[283.205015] Starting dynamic subtest: pipe-B-eDP-1
[284.745376] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.547s)
[284.753509] Starting dynamic subtest: pipe-C-eDP-1
[286.234308] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s)
[286.242396] Starting dynamic subtest: pipe-D-eDP-1
[287.779747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.544s)
[287.780708] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.403s)
[288.984795] [061/132] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[289.086045] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[289.087673] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[289.215672] [062/132] (743s left) vgem_basic (busy-fence)
[289.249205] Starting subtest: busy-fence
[289.250096] Subtest busy-fence: SUCCESS (0.000s)
[289.329112] [063/132] (743s left) gem_ctx_shared (detached-shared-gtt)
[289.388317] Starting subtest: detached-shared-gtt
[291.542604] Subtest detached-shared-gtt: SUCCESS (2.152s)
[291.993179] [064/132] (741s left) kms_atomic_interruptible (legacy-dpms)
[292.080982] Starting subtest: legacy-dpms
[292.081888] Starting dynamic subtest: pipe-A-eDP-1
[299.519196] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.436s)
[299.520000] Subtest legacy-dpms: SUCCESS (7.438s)
[300.340188] [065/132] (732s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[305.311548] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[305.312458] Starting dynamic subtest: pipe-A-eDP-1
[306.089018] Dynamic subtest pipe-A-eDP-1: SKIP (0.776s)
[306.098576] Starting dynamic subtest: pipe-B-eDP-1
[307.217157] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[307.218785] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.906s)
[308.428798] [066/132] (724s left) kms_cursor_legacy (torture-bo)
[308.540574] Starting subtest: torture-bo
[308.541528] Starting dynamic subtest: pipe-A
[314.719117] Dynamic subtest pipe-A: SUCCESS (6.174s)
[314.729644] Starting dynamic subtest: pipe-B
[321.016716] Dynamic subtest pipe-B: SUCCESS (6.295s)
[321.027594] Starting dynamic subtest: pipe-C
[327.740543] Dynamic subtest pipe-C: SUCCESS (6.721s)
[327.750846] Starting dynamic subtest: pipe-D
[334.581468] Dynamic subtest pipe-D: SUCCESS (6.839s)
[334.592631] Starting dynamic subtest: all-pipes
[341.396811] Dynamic subtest all-pipes: SUCCESS (6.812s)
[341.398229] Subtest torture-bo: SUCCESS (32.853s)
[341.571582] [067/132] (691s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[341.665704] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[348.360618] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.694s)
[348.517171] [068/132] (684s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[348.611186] Starting subtest: fbcpsr-shrfb-scaledprimary
[354.443453] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.833s)
[354.632449] [069/132] (678s left) gem_ppgtt (shrink-vs-evict-pinned)
[354.693458] Starting subtest: shrink-vs-evict-pinned
[360.137359] Subtest shrink-vs-evict-pinned: SUCCESS (5.441s)
[360.232046] [070/132] (673s left) kms_flip (flip-vs-blocking-wf-vblank)
[360.335666] Starting subtest: flip-vs-blocking-wf-vblank
[360.337877] Starting dynamic subtest: A-eDP1
[369.218061] Dynamic subtest A-eDP1: SUCCESS (8.880s)
[369.227573] Starting dynamic subtest: B-eDP1
[378.155641] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[378.165423] Starting dynamic subtest: C-eDP1
[387.078343] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[387.092626] Starting dynamic subtest: D-eDP1
[396.012148] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[396.015151] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.678s)
[397.256003] [071/132] (636s left) syncobj_timeline (wait-all-interrupted)
[397.317684] Starting subtest: wait-all-interrupted
[397.422548] Subtest wait-all-interrupted: SUCCESS (0.102s)
[397.514832] [072/132] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[397.620280] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[404.403658] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.785s)
[404.568308] [073/132] (628s left) gem_mmap_gtt (cpuset-big-copy)
[404.641721] Subtest cpuset-big-copy: SKIP (0.000s)
[404.705228] [074/132] (628s left) kms_hdr (invalid-metadata-sizes)
[404.797686] Starting subtest: invalid-metadata-sizes
[404.800537] Subtest invalid-metadata-sizes: SKIP (0.000s)
[404.888312] [075/132] (628s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[404.981097] Starting subtest: plane-all-modeset-transition-fencing
[404.982848] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[405.072979] [076/132] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[405.164332] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[411.836674] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.673s)
[412.005197] [077/132] (621s left) gem_exec_reloc (basic-concurrent16)
[412.054662] Subtest basic-concurrent16: SKIP (0.000s)
[412.138361] [078/132] (621s left) kms_pm_rpm (legacy-planes-dpms)
[414.255397] Starting subtest: legacy-planes-dpms
[414.256653] Starting dynamic subtest: plane-63
[422.531541] Dynamic subtest plane-63: SUCCESS (8.278s)
[422.543047] Starting dynamic subtest: plane-93
[430.809159] Dynamic subtest plane-93: SUCCESS (8.274s)
[430.825946] Starting dynamic subtest: plane-123
[439.382640] Dynamic subtest plane-123: SUCCESS (8.569s)
[439.393788] Starting dynamic subtest: plane-133
[447.981817] Dynamic subtest plane-133: SUCCESS (8.598s)
[447.984702] Subtest legacy-planes-dpms: SUCCESS (33.731s)
[448.369984] [079/132] (585s left) kms_selftest (drm_cmdline_parser)
[448.411464] Starting subtest: drm_cmdline_parser
[448.449697] Starting dynamic subtest: drm_test_cmdline_force_d_only
[448.579370] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.126s)
[448.588632] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[448.717846] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.138s)
[448.726291] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[448.855061] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.136s)
[448.863598] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[448.981858] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.126s)
[448.990869] Starting dynamic subtest: drm_test_cmdline_force_e_only
[449.102908] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.121s)
[449.112048] Starting dynamic subtest: drm_test_cmdline_res
[449.242778] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.139s)
[449.250667] Starting dynamic subtest: drm_test_cmdline_res_vesa
[449.363153] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.122s)
[449.370855] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[449.498324] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.132s)
[449.507293] Starting dynamic subtest: drm_test_cmdline_res_rblank
[449.604531] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.107s)
[449.613847] Starting dynamic subtest: drm_test_cmdline_res_bpp
[449.727910] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.121s)
[449.736993] Starting dynamic subtest: drm_test_cmdline_res_refresh
[449.856908] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.129s)
[449.865747] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[449.958711] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.103s)
[449.966308] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[450.079117] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.118s)
[450.088672] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[450.219744] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.140s)
[450.227506] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[450.358450] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.137s)
[450.367535] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[450.488015] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.129s)
[450.496189] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[450.640317] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.152s)
[450.647929] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[450.768737] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.128s)
[450.776304] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[450.903200] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.135s)
[450.910797] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[451.047829] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.142s)
[451.055699] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[451.175733] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.127s)
[451.183505] Starting dynamic subtest: drm_test_cmdline_name
[451.316007] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.139s)
[451.323891] Starting dynamic subtest: drm_test_cmdline_name_bpp
[451.451388] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.135s)
[451.459035] Starting dynamic subtest: drm_test_cmdline_name_option
[451.541370] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.090s)
[451.550389] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[451.639830] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.098s)
[451.647503] Starting dynamic subtest: drm_test_cmdline_rotate_0
[451.750313] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.109s)
[451.759598] Starting dynamic subtest: drm_test_cmdline_rotate_90
[451.861882] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.111s)
[451.869495] Starting dynamic subtest: drm_test_cmdline_rotate_180
[451.950563] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.087s)
[451.959746] Starting dynamic subtest: drm_test_cmdline_rotate_270
[452.055029] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.103s)
[452.064217] Starting dynamic subtest: drm_test_cmdline_hmirror
[452.192311] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.135s)
[452.201603] Starting dynamic subtest: drm_test_cmdline_vmirror
[452.312424] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.119s)
[452.321821] Starting dynamic subtest: drm_test_cmdline_margin_options
[452.421334] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.110s)
[452.429016] Starting dynamic subtest: drm_test_cmdline_multiple_options
[452.543071] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.120s)
[452.552262] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[452.663370] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.120s)
[452.670983] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[452.776964] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.112s)
[452.786047] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[452.871853] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.096s)
[452.879591] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[452.982693] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.109s)
[452.991969] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[453.097256] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.113s)
[453.104901] Starting dynamic subtest: drm_test_cmdline_invalid
[453.227824] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.131s)
[453.235710] Starting dynamic subtest: drm_test_cmdline_tv_options
[453.345702] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.118s)
[453.346648] Subtest drm_cmdline_parser: SUCCESS (4.936s)
[453.556577] [080/132] (580s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[453.656160] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[453.657193] Starting dynamic subtest: pipe-A-eDP-1
[453.666720] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[453.675915] Starting dynamic subtest: pipe-B-eDP-1
[453.691627] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[453.700109] Starting dynamic subtest: pipe-C-eDP-1
[453.708597] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[453.716325] Starting dynamic subtest: pipe-D-eDP-1
[453.725165] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[453.726796] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[455.838337] [081/132] (577s left) kms_psr (psr2-sprite-blt)
[455.928943] Starting subtest: psr2-sprite-blt
[455.929768] Starting dynamic subtest: eDP-1
[457.617285] Dynamic subtest eDP-1: SUCCESS (1.688s)
[457.618119] Subtest psr2-sprite-blt: SUCCESS (1.689s)
[458.504106] [082/132] (575s left) kms_setmode (invalid-clone-exclusive-crtc)
[458.565742] Starting subtest: invalid-clone-exclusive-crtc
[458.568493] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[458.692812] [083/132] (575s left) kms_flip_event_leak (basic)
[458.786043] Starting subtest: basic
[458.786892] Starting dynamic subtest: pipe-A-eDP-1
[459.221017] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[459.233030] Starting dynamic subtest: pipe-B-eDP-1
[460.309266] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.086s)
[460.319686] Starting dynamic subtest: pipe-C-eDP-1
[461.425450] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[461.434706] Starting dynamic subtest: pipe-D-eDP-1
[462.562834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[462.563783] Subtest basic: SUCCESS (3.777s)
[463.445236] [084/132] (570s left) gem_workarounds (basic-read)
[463.517712] Starting subtest: basic-read
[463.528940] Subtest basic-read: SUCCESS (0.011s)
[463.694254] [085/132] (570s left) dmabuf_sync_file (import-multiple-read-only)
[463.732826] Starting subtest: import-multiple-read-only
[463.735344] Subtest import-multiple-read-only: SUCCESS (0.003s)
[463.809096] [086/132] (570s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[463.896707] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[464.280811] Starting dynamic subtest: pipe-A-eDP-1
[467.016092] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.732s)
[467.379550] Starting dynamic subtest: pipe-B-eDP-1
[470.146104] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[470.515112] Starting dynamic subtest: pipe-C-eDP-1
[473.275883] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[473.643726] Starting dynamic subtest: pipe-D-eDP-1
[476.406666] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[476.407513] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.509s)
[477.608149] [087/132] (556s left) kms_atomic (plane-overlay-legacy)
[477.696270] Starting subtest: plane-overlay-legacy
[477.697234] Starting dynamic subtest: pipe-A-eDP-1
[478.106154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[478.107149] Subtest plane-overlay-legacy: SUCCESS (0.410s)
[478.944451] [088/132] (555s left) gem_exec_balancer (parallel-balancer)
[479.200260] Starting subtest: parallel-balancer
[480.070187] Subtest parallel-balancer: SUCCESS (0.870s)
[480.199480] [089/132] (553s left) gem_mmap_gtt (basic-write-gtt)
[480.257231] Subtest basic-write-gtt: SKIP (0.000s)
[480.317619] [090/132] (553s left) perf_pmu (render-node-busy)
[480.403544] Starting subtest: render-node-busy
[480.405049] Starting dynamic subtest: rcs0
[481.020408] Dynamic subtest rcs0: SUCCESS (0.618s)
[481.031383] Starting dynamic subtest: bcs0
[481.589206] Dynamic subtest bcs0: SUCCESS (0.565s)
[481.600569] Starting dynamic subtest: vcs0
[483.052654] Dynamic subtest vcs0: SUCCESS (1.457s)
[483.072162] Starting dynamic subtest: vcs1
[485.033258] Dynamic subtest vcs1: SUCCESS (1.978s)
[485.044209] Starting dynamic subtest: vecs0
[487.018431] Dynamic subtest vecs0: SUCCESS (1.981s)
[487.028960] Starting dynamic subtest: ccs0
[487.592340] Dynamic subtest ccs0: SUCCESS (0.573s)
[487.593643] Subtest render-node-busy: SUCCESS (7.192s)
[487.702806] [091/132] (546s left) i915_pm_rpm (system-suspend-execbuf)
[489.335721] Starting subtest: system-suspend-execbuf
[547.577622] Subtest system-suspend-execbuf: SUCCESS (42.942s)
[547.955388] [092/132] (486s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[552.939208] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[552.940097] Starting dynamic subtest: pipe-A-eDP-1
[559.544606] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.604s)
[559.553502] Starting dynamic subtest: pipe-B-eDP-1
[566.021487] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.473s)
[566.022376] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.081s)
[566.913251] [093/132] (467s left) kms_vblank (wait-forked)
[567.010400] Starting subtest: wait-forked
[567.011206] Starting dynamic subtest: pipe-A-eDP-1
[568.817897] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.806s)
[568.827851] Starting dynamic subtest: pipe-D-eDP-1
[571.285415] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.465s)
[571.286463] Subtest wait-forked: SUCCESS (4.275s)
[572.186597] [094/132] (461s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[572.282981] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[572.284752] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[572.393165] [095/132] (461s left) gen9_exec_parse (allowed-single)
[572.450715] Subtest allowed-single: SKIP (0.000s)
[572.519566] [096/132] (461s left) syncobj_eventfd (timeline-wait)
[572.563496] Starting subtest: timeline-wait
[572.573917] Subtest timeline-wait: SUCCESS (0.011s)
[572.683213] [097/132] (461s left) kms_vblank (ts-continuation-modeset-rpm)
[572.773230] Starting subtest: ts-continuation-modeset-rpm
[572.774122] Starting dynamic subtest: pipe-A-eDP-1
[575.252565] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.478s)
[575.262154] Starting dynamic subtest: pipe-D-eDP-1
[577.487596] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.233s)
[577.488534] Subtest ts-continuation-modeset-rpm: SUCCESS (4.715s)
[578.300621] [098/132] (456s left) sw_sync (sync_busy)
[578.335207] Starting subtest: sync_busy
[578.338064] Subtest sync_busy: SUCCESS (0.002s)
[578.415894] [099/132] (455s left) gem_ctx_persistence (engines-persistence)
[578.470066] Starting subtest: engines-persistence
[578.471014] Starting dynamic subtest: rcs0
[579.340057] Dynamic subtest rcs0: SUCCESS (0.870s)
[579.352726] Starting dynamic subtest: bcs0
[580.140908] Dynamic subtest bcs0: SUCCESS (0.799s)
[580.153292] Starting dynamic subtest: vcs0
[580.877851] Dynamic subtest vcs0: SUCCESS (0.735s)
[580.889082] Starting dynamic subtest: vcs1
[581.648938] Dynamic subtest vcs1: SUCCESS (0.769s)
[581.660371] Starting dynamic subtest: vecs0
[582.458024] Dynamic subtest vecs0: SUCCESS (0.807s)
[582.471007] Starting dynamic subtest: ccs0
[583.279146] Dynamic subtest ccs0: SUCCESS (0.819s)
[583.280852] Subtest engines-persistence: SUCCESS (4.811s)
[583.379363] [100/132] (451s left) syncobj_basic (bad-handle-to-fd)
[583.430136] Starting subtest: bad-handle-to-fd
[583.431110] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[583.544215] [101/132] (450s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[583.591518] Starting subtest: yf-tiled-to-vebox-x-tiled
[583.593487] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[583.792589] [102/132] (450s left) syncobj_timeline (invalid-wait-illegal-handle)
[583.845296] Starting subtest: invalid-wait-illegal-handle
[583.846265] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[583.957607] [103/132] (450s left) i915_drm_fdinfo (memory-info-idle)
[583.992214] Starting subtest: memory-info-idle
[583.993125] Starting dynamic subtest: smem0
[584.055177] Dynamic subtest smem0: SUCCESS (0.064s)
[584.056154] Subtest memory-info-idle: SUCCESS (0.065s)
[584.147257] [104/132] (450s left) gem_softpin (noreloc)
[584.202462] Starting subtest: noreloc
[589.590053] Subtest noreloc: SUCCESS (5.385s)
[589.755973] [105/132] (444s left) i915_pm_sseu (full-enable)
[589.817157] Subtest full-enable: SKIP (0.000s)
[589.959499] [106/132] (444s left) gem_ctx_engines (execute-oneforall)
[590.039711] Starting subtest: execute-oneforall
[590.950147] Subtest execute-oneforall: SUCCESS (0.908s)
[592.568167] [107/132] (442s left) gem_exec_whisper (basic-normal)
[592.634535] Starting subtest: basic-normal
[597.593836] Subtest basic-normal: SUCCESS (4.957s)
[597.793761] [108/132] (436s left) syncobj_basic (bad-flags-handle-to-fd)
[597.847388] Starting subtest: bad-flags-handle-to-fd
[597.848323] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[597.963679] [109/132] (436s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[598.058904] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[598.060708] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[598.179269] [110/132] (436s left) gem_exec_schedule (thriceslice)
[598.240207] Starting subtest: thriceslice
[598.241099] Starting dynamic subtest: rcs0
[598.271774] Dynamic subtest rcs0: SUCCESS (0.031s)
[598.281865] Starting dynamic subtest: bcs0
[598.300949] Dynamic subtest bcs0: SUCCESS (0.028s)
[598.308907] Starting dynamic subtest: vcs0
[598.351153] Dynamic subtest vcs0: SUCCESS (0.049s)
[598.362586] Starting dynamic subtest: vcs1
[598.380545] Dynamic subtest vcs1: SUCCESS (0.028s)
[598.390526] Starting dynamic subtest: vecs0
[598.408268] Dynamic subtest vecs0: SUCCESS (0.027s)
[598.416435] Starting dynamic subtest: ccs0
[598.459530] Dynamic subtest ccs0: SUCCESS (0.050s)
[598.461063] Subtest thriceslice: SUCCESS (0.220s)
[598.781902] [111/132] (435s left) syncobj_wait (multi-wait-submitted-signaled)
[598.836663] Starting subtest: multi-wait-submitted-signaled
[598.837817] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[598.968379] [112/132] (435s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[599.069063] Starting subtest: yf-tiled-8bpp-rotate-270
[599.070922] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[599.192565] [113/132] (435s left) gem_userptr_blits (access-control)
[599.260259] Starting subtest: access-control
[599.262016] Subtest access-control: SKIP (0.000s)
[599.414465] [114/132] (435s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[599.511603] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[603.130889] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.619s)
[604.335445] [115/132] (430s left) gem_ctx_persistence (idempotent)
[604.393165] Starting subtest: idempotent
[604.394206] Subtest idempotent: SUCCESS (0.000s)
[604.509074] [116/132] (430s left) kms_flip (2x-flip-vs-fences-interruptible)
[604.605305] Starting subtest: 2x-flip-vs-fences-interruptible
[604.606974] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[604.745831] [117/132] (430s left) gem_userptr_blits (map-fixed-invalidate)
[604.798832] Starting subtest: map-fixed-invalidate
[604.800691] Subtest map-fixed-invalidate: SKIP (0.000s)
[604.952283] [118/132] (430s left) gem_bad_reloc (negative-reloc-lut)
[605.013535] Subtest negative-reloc-lut: SKIP (0.000s)
[605.096798] [119/132] (429s left) kms_fbcon_fbt (fbc-suspend)
[605.154031] Starting subtest: fbc-suspend
[655.201547] Subtest fbc-suspend: SUCCESS (19.717s)
[659.588686] [120/132] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[659.686016] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[659.687851] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[659.827809] [121/132] (378s left) kms_psr (psr-cursor-mmap-gtt)
[659.920614] Starting subtest: psr-cursor-mmap-gtt
[659.921425] Starting dynamic subtest: eDP-1
[661.600526] Dynamic subtest eDP-1: SUCCESS (1.679s)
[661.601373] Subtest psr-cursor-mmap-gtt: SUCCESS (1.680s)
[662.481687] [122/132] (375s left) kms_color_pipeline (plane-lut1d)
[662.573855] Starting subtest: plane-lut1d
[662.587566] Starting dynamic subtest: pipe-A-eDP-1
[663.029604] Dynamic subtest pipe-A-eDP-1: FAIL (0.293s)
[663.945431] Starting dynamic subtest: pipe-B-eDP-1
[664.434875] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[665.380764] Starting dynamic subtest: pipe-C-eDP-1
[665.823436] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[666.712930] Starting dynamic subtest: pipe-D-eDP-1
[667.157527] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[667.237188] Subtest plane-lut1d: FAIL (4.663s)
[668.114815] [123/132] (370s left) gem_userptr_blits (readonly-pwrite-unsync)
[668.173208] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[668.335959] [124/132] (369s left) gem_close (basic)
[668.389548] Starting subtest: basic
[668.390447] Subtest basic: SUCCESS (0.000s)
[668.519290] [125/132] (369s left) kms_chamelium_color (ctm-red-to-blue)
[668.604200] Subtest ctm-red-to-blue: SKIP (0.000s)
[668.644524] [126/132] (369s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[668.866612] Starting subtest: cursor-rapid-movement-256x256
[668.868894] Starting dynamic subtest: pipe-A-eDP-1
[669.424131] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.554s)
[669.450895] Starting dynamic subtest: pipe-D-eDP-1
[670.600508] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.156s)
[670.601413] Subtest cursor-rapid-movement-256x256: SUCCESS (1.735s)
[671.504019] [127/132] (366s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[671.623750] Starting subtest: basic-flip-after-cursor-varying-size
[672.553480] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.929s)
[673.417559] [128/132] (364s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[673.522720] Starting subtest: fbc-psr-sprite-mmap-gtt
[673.524202] Starting dynamic subtest: eDP-1
[673.526506] Dynamic subtest eDP-1: SKIP (0.000s)
[673.528574] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.003s)
[673.629811] [129/132] (364s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[673.735373] Starting subtest: yf-tiled-16bpp-rotate-90
[673.737442] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[673.868085] [130/132] (364s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[673.976442] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[673.978168] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[674.110197] [131/132] (364s left) kms_prop_blob (blob-prop-lifetime)
[674.176221] Starting subtest: blob-prop-lifetime
[674.177181] Subtest blob-prop-lifetime: SUCCESS (0.002s)
[674.313602] [132/132] (364s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[674.416636] Starting subtest: y-tiled-16bpp-rotate-270
[674.418337] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[674.550525] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_tiled_pread_basic
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: gem_exec_whisper
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: gem_fenced_exec_thrash
results: parsing output: 25/ for test: kms_chamelium_frames
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: api_intel_bb
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: i915_pciid
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: gem_exec_flush
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_pipe_stress
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_pxp
results: parsing output: 41/ for test: kms_rotation_crc
results: parsing output: 42/ for test: api_intel_bb
results: parsing output: 43/ for test: kms_pm_backlight
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: kms_invalid_mode
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: kms_getfb
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_atomic_interruptible
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_ppgtt
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_hdr
results: parsing output: 74/ for test: kms_atomic_transition
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_selftest
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_setmode
results: parsing output: 82/ for test: kms_flip_event_leak
results: parsing output: 83/ for test: gem_workarounds
results: parsing output: 84/ for test: dmabuf_sync_file
results: parsing output: 85/ for test: kms_async_flips
results: parsing output: 86/ for test: kms_atomic
results: parsing output: 87/ for test: gem_exec_balancer
results: parsing output: 88/ for test: gem_mmap_gtt
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: i915_pm_rpm
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gen9_exec_parse
results: parsing output: 95/ for test: syncobj_eventfd
results: parsing output: 96/ for test: kms_vblank
results: parsing output: 97/ for test: sw_sync
results: parsing output: 98/ for test: gem_ctx_persistence
results: parsing output: 99/ for test: syncobj_basic
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: i915_drm_fdinfo
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: i915_pm_sseu
results: parsing output: 105/ for test: gem_ctx_engines
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: syncobj_basic
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_ctx_persistence
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gem_bad_reloc
results: parsing output: 118/ for test: kms_fbcon_fbt
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_color_pipeline
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: gem_close
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_prop_blob
results: parsing output: 131/ for test: kms_big_fb
Done.