[57.220944] Initializing watchdogs
[57.221226]   /dev/watchdog0
[57.234838] [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]
[57.238972] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.241213] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.244339] [001/132] (960s left) gem_exec_schedule (independent)
[57.336164] Starting subtest: independent
[57.338260] Starting dynamic subtest: rcs0
[58.903339] Dynamic subtest rcs0: SUCCESS (1.588s)
[58.913825] Starting dynamic subtest: vcs0
[60.896518] Dynamic subtest vcs0: SUCCESS (2.006s)
[60.907877] Starting dynamic subtest: vcs1
[62.975995] Dynamic subtest vcs1: SUCCESS (2.089s)
[62.987355] Starting dynamic subtest: vecs0
[64.945382] Dynamic subtest vecs0: SUCCESS (1.975s)
[64.955341] Starting dynamic subtest: ccs0
[67.007022] Dynamic subtest ccs0: SUCCESS (2.065s)
[67.010088] Subtest independent: SUCCESS (9.731s)
[67.378513] [002/132] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[67.696732] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[67.701082] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[67.868884] [003/132] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[68.067725] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[68.072079] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[68.181092] [004/132] (949s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[68.248209] Starting subtest: invalid-signal-one-illegal-handle
[68.250577] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[68.380921] [005/132] (949s left) gem_softpin (32b-excludes-last-page)
[68.435045] Starting subtest: 32b-excludes-last-page
[68.439429] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[68.595837] [006/132] (949s left) gem_mmap_gtt (basic-copy)
[68.647830] Subtest basic-copy: SKIP (0.000s)
[68.702529] [007/132] (949s left) kms_content_protection (atomic-dpms-hdcp14)
[68.854719] Starting subtest: atomic-dpms-hdcp14
[68.859432] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[69.028939] [008/132] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[69.129083] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[76.008541] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.891s)
[76.178314] [009/132] (941s left) gem_mmap_gtt (coherency)
[76.245951] Subtest coherency: SKIP (0.000s)
[76.303421] [010/132] (941s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[76.397960] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[76.400196] Starting dynamic subtest: pipe-A-default-mode
[79.205419] Dynamic subtest pipe-A-default-mode: SUCCESS (2.807s)
[79.207515] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.808s)
[80.057904] [011/132] (938s left) kms_cursor_crc (cursor-offscreen-512x170)
[80.338314] Starting subtest: cursor-offscreen-512x170
[80.342716] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[80.519761] [012/132] (937s left) perf_pmu (busy-double-start)
[80.558774] Starting subtest: busy-double-start
[80.560826] Starting dynamic subtest: rcs0
[84.195466] Dynamic subtest rcs0: FAIL (3.586s)
[84.204423] Starting dynamic subtest: bcs0
[87.717908] Dynamic subtest bcs0: SUCCESS (3.572s)
[87.726088] Starting dynamic subtest: vcs0
[91.419786] Dynamic subtest vcs0: SUCCESS (3.700s)
[91.429817] Starting dynamic subtest: vcs1
[95.453753] Dynamic subtest vcs1: SUCCESS (4.032s)
[95.463490] Starting dynamic subtest: vecs0
[99.452283] Dynamic subtest vecs0: SUCCESS (3.996s)
[99.462300] Starting dynamic subtest: ccs0
[103.089374] Dynamic subtest ccs0: FAIL (3.566s)
[103.091427] Subtest busy-double-start: FAIL (22.457s)
[103.158830] [013/132] (915s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[103.276688] Starting subtest: fbc-rgb565-draw-pwrite
[107.822551] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.557s)
[108.957091] [014/132] (909s left) gem_tiled_pread_basic
[109.089830] [015/132] (909s left) kms_psr (fbc-psr2-cursor-plane-move)
[109.186015] Starting subtest: fbc-psr2-cursor-plane-move
[109.188168] Starting dynamic subtest: eDP-1
[109.192330] Dynamic subtest eDP-1: SKIP (0.000s)
[109.196678] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[109.275681] [016/132] (909s left) gem_render_copy (y-tiled-ccs-to-linear)
[109.350143] Starting subtest: y-tiled-ccs-to-linear
[109.354671] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[109.555504] [017/132] (908s left) kms_color (ctm-0-25)
[109.647093] Starting subtest: ctm-0-25
[109.649141] Starting dynamic subtest: pipe-A-eDP-1
[113.044498] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.398s)
[113.053743] Starting dynamic subtest: pipe-B-eDP-1
[117.381393] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.336s)
[117.395062] Starting dynamic subtest: pipe-C-eDP-1
[121.391469] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.008s)
[121.403842] Starting dynamic subtest: pipe-D-eDP-1
[125.382067] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.993s)
[125.384266] Subtest ctm-0-25: SUCCESS (15.736s)
[126.228037] [018/132] (892s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[126.805983] Starting subtest: syncobj-timeline-multiple-ext-nodes
[126.808899] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[128.015901] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[128.019381] [019/132] (890s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[128.122769] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[128.133053] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[128.251966] [020/132] (890s left) gem_mmap_gtt (fault-concurrent-y)
[128.309382] Subtest fault-concurrent-Y: SKIP (0.000s)
[128.372094] [021/132] (890s left) syncobj_timeline (reset-signaled)
[128.420032] Starting subtest: reset-signaled
[128.422422] Subtest reset-signaled: SUCCESS (0.000s)
[128.550904] [022/132] (890s left) kms_lease (simple-lease)
[128.652039] Starting subtest: simple-lease
[128.654379] Starting dynamic subtest: pipe-A-eDP-1
[129.186084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.533s)
[129.194117] Starting dynamic subtest: pipe-B-eDP-1
[130.655397] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.468s)
[130.664344] Starting dynamic subtest: pipe-C-eDP-1
[132.064969] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s)
[132.073516] Starting dynamic subtest: pipe-D-eDP-1
[133.466479] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[133.468726] Subtest simple-lease: SUCCESS (4.815s)
[134.282293] [023/132] (884s left) gem_exec_whisper (basic-queues-priority-all)
[134.343460] Starting subtest: basic-queues-priority-all
[156.216621] Subtest basic-queues-priority-all: SUCCESS (21.871s)
[156.423490] [024/132] (862s left) gem_exec_balancer (parallel-ordering)
[156.684619] Starting subtest: parallel-ordering
[157.660100] Subtest parallel-ordering: SUCCESS (0.975s)
[157.838190] [025/132] (860s left) gem_fenced_exec_thrash (too-many-fences)
[157.916601] Subtest too-many-fences: SKIP (0.000s)
[158.000941] [026/132] (860s left) kms_chamelium_frames (dp-crc-single)
[158.408743] Subtest dp-crc-single: SKIP (0.000s)
[159.188265] [027/132] (859s left) kms_big_fb (linear-16bpp-rotate-90)
[159.302207] Starting subtest: linear-16bpp-rotate-90
[159.321654] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[159.489236] [028/132] (859s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[159.593759] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[159.597728] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[159.711948] [029/132] (859s left) api_intel_bb (crc32)
[159.776463] Starting subtest: crc32
[159.778678] Starting dynamic subtest: rcs0-smem0
[160.075084] Dynamic subtest rcs0-smem0: SUCCESS (0.298s)
[160.086977] Starting dynamic subtest: bcs0-smem0
[160.403876] Dynamic subtest bcs0-smem0: SUCCESS (0.327s)
[160.416160] Starting dynamic subtest: vcs0-smem0
[160.739405] Dynamic subtest vcs0-smem0: SUCCESS (0.334s)
[160.751087] Starting dynamic subtest: vcs1-smem0
[161.084221] Dynamic subtest vcs1-smem0: SUCCESS (0.342s)
[161.095820] Starting dynamic subtest: vecs0-smem0
[161.429255] Dynamic subtest vecs0-smem0: SUCCESS (0.343s)
[161.441455] Starting dynamic subtest: ccs0-smem0
[161.761937] Dynamic subtest ccs0-smem0: SUCCESS (0.331s)
[161.764963] Subtest crc32: SUCCESS (1.986s)
[161.916449] [030/132] (856s left) kms_psr (fbc-pr-sprite-plane-onoff)
[162.015576] Starting subtest: fbc-pr-sprite-plane-onoff
[162.019770] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[162.107110] [031/132] (856s left) gem_eio (wait-1us)
[162.346641] Starting subtest: wait-1us
[162.660657] Subtest wait-1us: SUCCESS (0.316s)
[162.821376] [032/132] (856s left) kms_feature_discovery (chamelium)
[162.910478] Starting subtest: chamelium
[162.913969] Subtest chamelium: SKIP (0.000s)
[163.004911] [033/132] (855s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[163.109202] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[163.112651] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[163.238891] [034/132] (855s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[163.337962] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[163.339569] Starting dynamic subtest: A-eDP1
[166.907712] Dynamic subtest A-eDP1: SUCCESS (3.568s)
[166.917487] Starting dynamic subtest: B-eDP1
[170.133586] Dynamic subtest B-eDP1: SUCCESS (3.225s)
[170.142696] Starting dynamic subtest: C-eDP1
[173.222053] Dynamic subtest C-eDP1: SUCCESS (3.089s)
[173.231408] Starting dynamic subtest: D-eDP1
[176.318083] Dynamic subtest D-eDP1: SUCCESS (3.092s)
[176.320083] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.981s)
[177.134446] [035/132] (841s left) i915_pciid
[177.341147] [036/132] (841s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[177.446950] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[177.448864] Starting dynamic subtest: pipe-A
[177.795508] Dynamic subtest pipe-A: SUCCESS (0.351s)
[177.803950] Starting dynamic subtest: pipe-B
[179.205976] Dynamic subtest pipe-B: SUCCESS (1.410s)
[179.213806] Starting dynamic subtest: pipe-C
[180.645726] Dynamic subtest pipe-C: SUCCESS (1.439s)
[180.655365] Starting dynamic subtest: pipe-D
[182.104352] Dynamic subtest pipe-D: SUCCESS (1.457s)
[182.106724] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.660s)
[183.359150] [037/132] (835s left) gem_exec_flush (basic-wb-ro-before-default)
[183.436512] Starting subtest: basic-wb-ro-before-default
[188.890617] Subtest basic-wb-ro-before-default: SUCCESS (5.456s)
[189.100102] [038/132] (830s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[189.219929] Starting subtest: 4-tiled-8bpp-rotate-180
[190.382578] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.162s)
[190.535097] [039/132] (828s left) kms_pipe_stress (stress-xrgb8888-untiled)
[190.637036] Starting subtest: stress-xrgb8888-untiled
[196.552919] Subtest stress-xrgb8888-untiled: SUCCESS (5.915s)
[196.611459] [040/132] (822s left) gem_exec_reloc (basic-cpu-wc-active)
[196.677051] Subtest basic-cpu-wc-active: SKIP (0.000s)
[196.752218] [041/132] (822s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[196.880753] Starting subtest: verify-pxp-key-change-after-suspend-resume
[207.753619] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (10.875s)
[207.915701] [042/132] (811s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[208.034191] Starting subtest: primary-yf-tiled-reflect-x-90
[208.038650] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[208.129359] [043/132] (811s left) api_intel_bb (blit-noreloc-keep-cache)
[208.188064] Starting subtest: blit-noreloc-keep-cache
[208.195574] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[208.366991] [044/132] (811s left) kms_pm_backlight (fade-with-suspend)
[208.461197] Starting subtest: fade-with-suspend
[224.836804] Starting dynamic subtest: eDP-1
[227.497324] Dynamic subtest eDP-1: SUCCESS (2.764s)
[227.499794] Subtest fade-with-suspend: SUCCESS (4.036s)
[228.346288] [045/132] (791s left) kms_addfb_basic (small-bo)
[228.447182] Starting subtest: small-bo
[228.448996] Subtest small-bo: SUCCESS (0.000s)
[228.573326] [046/132] (790s left) gem_userptr_blits (mmap-offset-banned)
[228.643016] Starting subtest: mmap-offset-banned
[228.645376] Starting dynamic subtest: wb
[228.647543] Dynamic subtest wb: SUCCESS (0.000s)
[228.657081] Starting dynamic subtest: wc
[228.658946] Dynamic subtest wc: SUCCESS (0.000s)
[228.666803] Starting dynamic subtest: uc
[228.668675] Dynamic subtest uc: SUCCESS (0.000s)
[228.670534] Subtest mmap-offset-banned: SUCCESS (0.002s)
[228.795307] [047/132] (790s left) kms_invalid_mode (zero-vdisplay)
[228.883680] Starting subtest: zero-vdisplay
[228.885875] Starting dynamic subtest: pipe-A-eDP-1
[229.174282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[229.183152] Starting dynamic subtest: pipe-B-eDP-1
[229.185385] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[229.193450] Starting dynamic subtest: pipe-C-eDP-1
[229.195677] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[229.203877] Starting dynamic subtest: pipe-D-eDP-1
[229.205790] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[229.207680] Subtest zero-vdisplay: SUCCESS (0.307s)
[230.054609] [048/132] (789s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[230.145072] Starting subtest: psr-rgb101010-draw-pwrite
[237.449460] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.419s)
[237.575972] [049/132] (782s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[237.677535] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[237.679761] Starting dynamic subtest: pipe-A-eDP-1
[237.736984] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[237.747615] Starting dynamic subtest: pipe-B-eDP-1
[237.803384] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[237.812932] Starting dynamic subtest: pipe-C-eDP-1
[237.870670] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[237.880724] Starting dynamic subtest: pipe-D-eDP-1
[237.939051] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[237.943145] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[239.946526] [050/132] (779s left) kms_cursor_crc (cursor-sliding-max-size)
[240.266419] Starting subtest: cursor-sliding-max-size
[240.273134] Subtest cursor-sliding-max-size: SKIP (0.000s)
[240.425997] [051/132] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[240.519220] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[240.523326] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[240.635923] [052/132] (779s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[240.700764] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[240.805257] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[240.904760] [053/132] (778s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[240.999090] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[241.003125] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[241.117805] [054/132] (778s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[241.213112] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[241.215289] Starting dynamic subtest: pipe-A-eDP-1
[241.237360] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[241.249516] Starting dynamic subtest: pipe-B-eDP-1
[241.269516] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[241.277711] Starting dynamic subtest: pipe-C-eDP-1
[241.298092] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[241.306387] Starting dynamic subtest: pipe-D-eDP-1
[241.327817] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[241.332168] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[243.407147] [055/132] (776s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[243.514288] Starting subtest: x-tiled-16bpp-rotate-90
[243.535211] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[243.673327] [056/132] (776s left) kms_plane (plane-panning-top-left)
[243.764820] Starting subtest: plane-panning-top-left
[243.767217] Starting dynamic subtest: pipe-A
[245.418636] Dynamic subtest pipe-A: SUCCESS (1.659s)
[245.428526] Starting dynamic subtest: pipe-B
[247.789492] Dynamic subtest pipe-B: SUCCESS (2.376s)
[247.791717] Subtest plane-panning-top-left: SUCCESS (4.039s)
[248.609606] [057/132] (771s left) kms_getfb (getfb-handle-zero)
[248.711895] Starting subtest: getfb-handle-zero
[248.714263] Subtest getfb-handle-zero: SUCCESS (0.000s)
[248.859704] [058/132] (771s left) kms_flip (dpms-vs-vblank-race-interruptible)
[248.961661] Starting subtest: dpms-vs-vblank-race-interruptible
[248.964065] Starting dynamic subtest: A-eDP1
[253.856629] Dynamic subtest A-eDP1: SUCCESS (4.902s)
[253.866305] Starting dynamic subtest: B-eDP1
[258.485284] Dynamic subtest B-eDP1: SUCCESS (4.630s)
[258.496224] Starting dynamic subtest: C-eDP1
[263.112670] Dynamic subtest C-eDP1: SUCCESS (4.622s)
[263.121912] Starting dynamic subtest: D-eDP1
[267.649087] Dynamic subtest D-eDP1: SUCCESS (4.534s)
[267.651281] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.696s)
[268.555681] [059/132] (751s left) kms_addfb_basic (bad-pitch-256)
[268.624583] Starting subtest: bad-pitch-256
[268.626765] Subtest bad-pitch-256: SUCCESS (0.000s)
[268.782013] [060/132] (751s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[268.871709] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[268.873828] Starting dynamic subtest: pipe-A-eDP-1
[269.638944] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.760s)
[269.648049] Starting dynamic subtest: pipe-B-eDP-1
[271.182864] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.543s)
[271.192049] Starting dynamic subtest: pipe-C-eDP-1
[272.645604] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.461s)
[272.654451] Starting dynamic subtest: pipe-D-eDP-1
[274.174086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.526s)
[274.176135] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.295s)
[275.379157] [061/132] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[275.494586] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[275.498502] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[275.624119] [062/132] (744s left) vgem_basic (busy-fence)
[275.674331] Starting subtest: busy-fence
[275.676500] Subtest busy-fence: SUCCESS (0.000s)
[275.753039] [063/132] (744s left) gem_ctx_shared (detached-shared-gtt)
[275.816492] Starting subtest: detached-shared-gtt
[277.966938] Subtest detached-shared-gtt: SUCCESS (2.151s)
[278.348410] [064/132] (741s left) kms_atomic_interruptible (legacy-dpms)
[278.452274] Starting subtest: legacy-dpms
[278.454472] Starting dynamic subtest: pipe-A-eDP-1
[285.892503] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.440s)
[285.894741] Subtest legacy-dpms: SUCCESS (7.441s)
[286.739415] [065/132] (733s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[291.788552] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[291.790921] Starting dynamic subtest: pipe-A-eDP-1
[292.596640] Dynamic subtest pipe-A-eDP-1: SKIP (0.804s)
[292.606851] Starting dynamic subtest: pipe-B-eDP-1
[293.729819] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[293.734082] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.940s)
[294.931894] [066/132] (725s left) kms_cursor_legacy (torture-bo)
[295.058871] Starting subtest: torture-bo
[295.060784] Starting dynamic subtest: pipe-A
[301.050455] Dynamic subtest pipe-A: SUCCESS (5.990s)
[301.062630] Starting dynamic subtest: pipe-B
[306.983027] Dynamic subtest pipe-B: SUCCESS (5.934s)
[306.998015] Starting dynamic subtest: pipe-C
[313.089295] Dynamic subtest pipe-C: SUCCESS (6.106s)
[313.101380] Starting dynamic subtest: pipe-D
[320.239362] Dynamic subtest pipe-D: SUCCESS (7.150s)
[320.252776] Starting dynamic subtest: all-pipes
[326.835267] Dynamic subtest all-pipes: SUCCESS (6.590s)
[326.837664] Subtest torture-bo: SUCCESS (31.780s)
[327.014013] [067/132] (693s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[327.130253] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[333.852320] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.722s)
[334.001533] [068/132] (686s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[334.093647] Starting subtest: fbcpsr-shrfb-scaledprimary
[339.912873] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.820s)
[340.037614] [069/132] (680s left) gem_ppgtt (shrink-vs-evict-pinned)
[340.107381] Starting subtest: shrink-vs-evict-pinned
[345.968939] Subtest shrink-vs-evict-pinned: SUCCESS (5.859s)
[346.077932] [070/132] (674s left) kms_flip (flip-vs-blocking-wf-vblank)
[346.190821] Starting subtest: flip-vs-blocking-wf-vblank
[346.193162] Starting dynamic subtest: A-eDP1
[355.075642] Dynamic subtest A-eDP1: SUCCESS (8.884s)
[355.086675] Starting dynamic subtest: B-eDP1
[364.006203] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[364.017012] Starting dynamic subtest: C-eDP1
[372.928957] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[372.940113] Starting dynamic subtest: D-eDP1
[381.858294] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[381.863517] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.675s)
[383.103732] [071/132] (637s left) syncobj_timeline (wait-all-interrupted)
[383.169897] Starting subtest: wait-all-interrupted
[383.270673] Subtest wait-all-interrupted: SUCCESS (0.102s)
[383.369220] [072/132] (637s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[383.473121] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[390.261869] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.793s)
[390.445032] [073/132] (630s left) gem_mmap_gtt (cpuset-big-copy)
[390.506377] Subtest cpuset-big-copy: SKIP (0.000s)
[390.568328] [074/132] (630s left) kms_hdr (invalid-metadata-sizes)
[390.671642] Starting subtest: invalid-metadata-sizes
[390.678351] Subtest invalid-metadata-sizes: SKIP (0.000s)
[390.767770] [075/132] (629s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[390.880392] Starting subtest: plane-all-modeset-transition-fencing
[390.884859] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[390.983995] [076/132] (629s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[391.086035] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[397.834793] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.753s)
[398.007978] [077/132] (622s left) gem_exec_reloc (basic-concurrent16)
[398.077270] Subtest basic-concurrent16: SKIP (0.000s)
[398.162602] [078/132] (622s left) kms_pm_rpm (legacy-planes-dpms)
[400.195056] Starting subtest: legacy-planes-dpms
[400.197112] Starting dynamic subtest: plane-63
[408.580250] Dynamic subtest plane-63: SUCCESS (8.389s)
[408.592700] Starting dynamic subtest: plane-93
[417.234869] Dynamic subtest plane-93: SUCCESS (8.654s)
[417.247234] Starting dynamic subtest: plane-123
[425.571623] Dynamic subtest plane-123: SUCCESS (8.336s)
[425.584519] Starting dynamic subtest: plane-133
[434.190498] Dynamic subtest plane-133: SUCCESS (8.619s)
[434.193016] Subtest legacy-planes-dpms: SUCCESS (34.008s)
[434.580106] [079/132] (586s left) kms_selftest (drm_cmdline_parser)
[434.620830] Starting subtest: drm_cmdline_parser
[434.678112] Starting dynamic subtest: drm_test_cmdline_force_d_only
[434.822913] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.143s)
[434.839304] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[434.967532] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.145s)
[434.978741] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[435.120503] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.152s)
[435.131331] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[435.255472] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.134s)
[435.267275] Starting dynamic subtest: drm_test_cmdline_force_e_only
[435.381651] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.126s)
[435.390526] Starting dynamic subtest: drm_test_cmdline_res
[435.515269] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.132s)
[435.526102] Starting dynamic subtest: drm_test_cmdline_res_vesa
[435.640506] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.126s)
[435.651173] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[435.787715] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.145s)
[435.798506] Starting dynamic subtest: drm_test_cmdline_res_rblank
[435.882690] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.095s)
[435.894120] Starting dynamic subtest: drm_test_cmdline_res_bpp
[436.012485] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.129s)
[436.023178] Starting dynamic subtest: drm_test_cmdline_res_refresh
[436.142593] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.128s)
[436.152830] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[436.275610] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.132s)
[436.286217] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[436.422611] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.147s)
[436.433014] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[436.547248] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.124s)
[436.558090] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[436.679357] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.130s)
[436.695872] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[436.822551] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.144s)
[436.838166] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[436.950816] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.127s)
[436.960811] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[437.064609] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.114s)
[437.075255] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[437.205666] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.141s)
[437.214307] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[437.347640] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.140s)
[437.358563] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[437.510842] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.162s)
[437.521910] Starting dynamic subtest: drm_test_cmdline_name
[437.654501] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.143s)
[437.665331] Starting dynamic subtest: drm_test_cmdline_name_bpp
[437.808665] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.154s)
[437.819840] Starting dynamic subtest: drm_test_cmdline_name_option
[437.929789] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.120s)
[437.940547] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[438.073520] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.144s)
[438.084629] Starting dynamic subtest: drm_test_cmdline_rotate_0
[438.189145] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.116s)
[438.199822] Starting dynamic subtest: drm_test_cmdline_rotate_90
[438.299671] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.111s)
[438.308205] Starting dynamic subtest: drm_test_cmdline_rotate_180
[438.389492] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.089s)
[438.398027] Starting dynamic subtest: drm_test_cmdline_rotate_270
[438.535724] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.145s)
[438.544281] Starting dynamic subtest: drm_test_cmdline_hmirror
[438.637646] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.101s)
[438.648327] Starting dynamic subtest: drm_test_cmdline_vmirror
[438.756479] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.117s)
[438.766316] Starting dynamic subtest: drm_test_cmdline_margin_options
[438.865527] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.110s)
[438.875934] Starting dynamic subtest: drm_test_cmdline_multiple_options
[438.985645] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.119s)
[438.996224] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[439.100777] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.115s)
[439.109700] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[439.228342] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.126s)
[439.238799] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[439.327996] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.099s)
[439.338572] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[439.448768] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.121s)
[439.457762] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[439.570735] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.118s)
[439.580627] Starting dynamic subtest: drm_test_cmdline_invalid
[439.719082] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.149s)
[439.728128] Starting dynamic subtest: drm_test_cmdline_tv_options
[439.850337] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.131s)
[439.852394] Subtest drm_cmdline_parser: SUCCESS (5.231s)
[440.075973] [080/132] (580s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[440.179541] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[440.181833] Starting dynamic subtest: pipe-A-eDP-1
[440.205053] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[440.215623] Starting dynamic subtest: pipe-B-eDP-1
[440.236763] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[440.245782] Starting dynamic subtest: pipe-C-eDP-1
[440.267753] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[440.278221] Starting dynamic subtest: pipe-D-eDP-1
[440.300174] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[440.304568] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[442.343554] [081/132] (578s left) kms_psr (psr2-sprite-blt)
[442.442511] Starting subtest: psr2-sprite-blt
[442.444774] Starting dynamic subtest: eDP-1
[444.228317] Dynamic subtest eDP-1: SUCCESS (1.784s)
[444.230783] Subtest psr2-sprite-blt: SUCCESS (1.785s)
[445.119938] [082/132] (575s left) kms_setmode (invalid-clone-exclusive-crtc)
[445.179684] Starting subtest: invalid-clone-exclusive-crtc
[445.186224] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[445.319699] [083/132] (575s left) kms_flip_event_leak (basic)
[445.417389] Starting subtest: basic
[445.419541] Starting dynamic subtest: pipe-A-eDP-1
[445.856289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[445.866084] Starting dynamic subtest: pipe-B-eDP-1
[447.013241] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s)
[447.023414] Starting dynamic subtest: pipe-C-eDP-1
[448.134979] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[448.145403] Starting dynamic subtest: pipe-D-eDP-1
[449.264891] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[449.266834] Subtest basic: SUCCESS (3.847s)
[450.152286] [084/132] (570s left) gem_workarounds (basic-read)
[450.229039] Starting subtest: basic-read
[450.238270] Subtest basic-read: SUCCESS (0.009s)
[450.384149] [085/132] (570s left) dmabuf_sync_file (import-multiple-read-only)
[450.425707] Starting subtest: import-multiple-read-only
[450.428124] Subtest import-multiple-read-only: SUCCESS (0.003s)
[450.509688] [086/132] (570s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[450.600474] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[450.982029] Starting dynamic subtest: pipe-A-eDP-1
[453.702195] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.718s)
[454.071577] Starting dynamic subtest: pipe-B-eDP-1
[456.833380] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[457.196228] Starting dynamic subtest: pipe-C-eDP-1
[459.959244] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s)
[460.319949] Starting dynamic subtest: pipe-D-eDP-1
[463.092016] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[463.094502] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.488s)
[464.295826] [087/132] (556s left) kms_atomic (plane-overlay-legacy)
[464.401554] Starting subtest: plane-overlay-legacy
[464.403708] Starting dynamic subtest: pipe-A-eDP-1
[464.852945] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[464.855352] Subtest plane-overlay-legacy: SUCCESS (0.453s)
[465.733413] [088/132] (555s left) gem_exec_balancer (parallel-balancer)
[465.999890] Starting subtest: parallel-balancer
[466.855050] Subtest parallel-balancer: SUCCESS (0.855s)
[467.019186] [089/132] (554s left) gem_mmap_gtt (basic-write-gtt)
[467.092238] Subtest basic-write-gtt: SKIP (0.000s)
[467.164902] [090/132] (554s left) perf_pmu (render-node-busy)
[467.240996] Starting subtest: render-node-busy
[467.243465] Starting dynamic subtest: rcs0
[467.849057] Dynamic subtest rcs0: SUCCESS (0.607s)
[467.861295] Starting dynamic subtest: bcs0
[468.423848] Dynamic subtest bcs0: SUCCESS (0.572s)
[468.436275] Starting dynamic subtest: vcs0
[470.025844] Dynamic subtest vcs0: SUCCESS (1.598s)
[470.039236] Starting dynamic subtest: vcs1
[472.007497] Dynamic subtest vcs1: SUCCESS (1.979s)
[472.019694] Starting dynamic subtest: vecs0
[473.993286] Dynamic subtest vecs0: SUCCESS (1.982s)
[474.005476] Starting dynamic subtest: ccs0
[474.565746] Dynamic subtest ccs0: SUCCESS (0.571s)
[474.568294] Subtest render-node-busy: SUCCESS (7.324s)
[474.667148] [091/132] (546s left) i915_pm_rpm (system-suspend-execbuf)
[476.192678] Starting subtest: system-suspend-execbuf
[536.709867] Subtest system-suspend-execbuf: SUCCESS (45.311s)
[537.116566] [092/132] (484s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[542.145974] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[542.148617] Starting dynamic subtest: pipe-A-eDP-1
[548.659694] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.515s)
[548.669886] Starting dynamic subtest: pipe-B-eDP-1
[555.298192] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.639s)
[555.300506] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.157s)
[556.199534] [093/132] (465s left) kms_vblank (wait-forked)
[556.310200] Starting subtest: wait-forked
[556.311976] Starting dynamic subtest: pipe-A-eDP-1
[558.129585] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[558.144200] Starting dynamic subtest: pipe-D-eDP-1
[560.659408] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[560.661271] Subtest wait-forked: SUCCESS (4.350s)
[561.553769] [094/132] (460s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[561.661728] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[561.665725] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[561.794580] [095/132] (459s left) gen9_exec_parse (allowed-single)
[561.862382] Subtest allowed-single: SKIP (0.000s)
[561.958503] [096/132] (459s left) syncobj_eventfd (timeline-wait)
[562.015790] Starting subtest: timeline-wait
[562.024251] Subtest timeline-wait: SUCCESS (0.011s)
[562.160648] [097/132] (459s left) kms_vblank (ts-continuation-modeset-rpm)
[562.258242] Starting subtest: ts-continuation-modeset-rpm
[562.260376] Starting dynamic subtest: pipe-A-eDP-1
[564.829381] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.572s)
[564.843959] Starting dynamic subtest: pipe-D-eDP-1
[567.089933] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.259s)
[567.092169] Subtest ts-continuation-modeset-rpm: SUCCESS (4.835s)
[567.898536] [098/132] (453s left) sw_sync (sync_busy)
[567.940312] Starting subtest: sync_busy
[567.942673] Subtest sync_busy: SUCCESS (0.002s)
[568.027734] [099/132] (453s left) gem_ctx_persistence (engines-persistence)
[568.089199] Starting subtest: engines-persistence
[568.091410] Starting dynamic subtest: rcs0
[568.916743] Dynamic subtest rcs0: SUCCESS (0.827s)
[568.931071] Starting dynamic subtest: bcs0
[569.700958] Dynamic subtest bcs0: SUCCESS (0.782s)
[569.713324] Starting dynamic subtest: vcs0
[570.575060] Dynamic subtest vcs0: SUCCESS (0.872s)
[570.588359] Starting dynamic subtest: vcs1
[571.364010] Dynamic subtest vcs1: SUCCESS (0.787s)
[571.376066] Starting dynamic subtest: vecs0
[572.237984] Dynamic subtest vecs0: SUCCESS (0.872s)
[572.250575] Starting dynamic subtest: ccs0
[573.066868] Dynamic subtest ccs0: SUCCESS (0.827s)
[573.069452] Subtest engines-persistence: SUCCESS (4.981s)
[573.171301] [100/132] (448s left) syncobj_basic (bad-handle-to-fd)
[573.229357] Starting subtest: bad-handle-to-fd
[573.231677] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[573.372317] [101/132] (448s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[573.427746] Starting subtest: yf-tiled-to-vebox-x-tiled
[573.432561] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[573.646864] [102/132] (448s left) syncobj_timeline (invalid-wait-illegal-handle)
[573.709665] Starting subtest: invalid-wait-illegal-handle
[573.711818] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[573.842560] [103/132] (448s left) i915_drm_fdinfo (memory-info-idle)
[573.877402] Starting subtest: memory-info-idle
[573.879783] Starting dynamic subtest: smem0
[573.955157] Dynamic subtest smem0: SUCCESS (0.077s)
[573.957798] Subtest memory-info-idle: SUCCESS (0.078s)
[574.056443] [104/132] (447s left) gem_softpin (noreloc)
[574.126258] Starting subtest: noreloc
[579.507600] Subtest noreloc: SUCCESS (5.382s)
[579.663033] [105/132] (442s left) i915_pm_sseu (full-enable)
[579.718843] Subtest full-enable: SKIP (0.000s)
[579.842322] [106/132] (442s left) gem_ctx_engines (execute-oneforall)
[579.900982] Starting subtest: execute-oneforall
[580.852482] Subtest execute-oneforall: SUCCESS (0.950s)
[581.730522] [107/132] (440s left) gem_exec_whisper (basic-normal)
[581.789393] Starting subtest: basic-normal
[587.188364] Subtest basic-normal: SUCCESS (5.402s)
[587.399296] [108/132] (434s left) syncobj_basic (bad-flags-handle-to-fd)
[587.458110] Starting subtest: bad-flags-handle-to-fd
[587.460441] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[587.601089] [109/132] (434s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[587.727275] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[587.731327] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[587.861069] [110/132] (434s left) gem_exec_schedule (thriceslice)
[587.925990] Starting subtest: thriceslice
[587.928064] Starting dynamic subtest: rcs0
[587.944907] Dynamic subtest rcs0: SUCCESS (0.030s)
[587.957549] Starting dynamic subtest: bcs0
[587.995887] Dynamic subtest bcs0: SUCCESS (0.050s)
[588.009253] Starting dynamic subtest: vcs0
[588.027879] Dynamic subtest vcs0: SUCCESS (0.030s)
[588.037850] Starting dynamic subtest: vcs1
[588.055535] Dynamic subtest vcs1: SUCCESS (0.028s)
[588.065191] Starting dynamic subtest: vecs0
[588.104670] Dynamic subtest vecs0: SUCCESS (0.048s)
[588.116154] Starting dynamic subtest: ccs0
[588.159539] Dynamic subtest ccs0: SUCCESS (0.053s)
[588.161807] Subtest thriceslice: SUCCESS (0.246s)
[589.623752] [111/132] (432s left) syncobj_wait (multi-wait-submitted-signaled)
[589.683900] Starting subtest: multi-wait-submitted-signaled
[589.685999] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[589.827471] [112/132] (432s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[589.934180] Starting subtest: yf-tiled-8bpp-rotate-270
[589.938726] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[590.063034] [113/132] (432s left) gem_userptr_blits (access-control)
[590.133690] Starting subtest: access-control
[590.138051] Subtest access-control: SKIP (0.000s)
[590.289296] [114/132] (432s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[590.389602] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[593.941054] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.552s)
[595.102008] [115/132] (427s left) gem_ctx_persistence (idempotent)
[595.157323] Starting subtest: idempotent
[595.159727] Subtest idempotent: SUCCESS (0.000s)
[595.308396] [116/132] (427s left) kms_flip (2x-flip-vs-fences-interruptible)
[595.403119] Starting subtest: 2x-flip-vs-fences-interruptible
[595.407605] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[595.552843] [117/132] (426s left) gem_userptr_blits (map-fixed-invalidate)
[595.630233] Starting subtest: map-fixed-invalidate
[595.634559] Subtest map-fixed-invalidate: SKIP (0.000s)
[595.786888] [118/132] (426s left) gem_bad_reloc (negative-reloc-lut)
[595.845926] Subtest negative-reloc-lut: SKIP (0.000s)
[595.929610] [119/132] (426s left) kms_fbcon_fbt (fbc-suspend)
[595.975799] Starting subtest: fbc-suspend
[645.902873] Subtest fbc-suspend: SUCCESS (19.661s)
[647.235762] [120/132] (375s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[647.344060] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[647.348825] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[647.482723] [121/132] (375s left) kms_psr (psr-cursor-mmap-gtt)
[647.595039] Starting subtest: psr-cursor-mmap-gtt
[647.597606] Starting dynamic subtest: eDP-1
[649.323875] Dynamic subtest eDP-1: SUCCESS (1.753s)
[649.326616] Subtest psr-cursor-mmap-gtt: SUCCESS (1.755s)
[650.188574] [122/132] (372s left) kms_color_pipeline (plane-lut1d)
[650.287966] Starting subtest: plane-lut1d
[650.300074] Starting dynamic subtest: pipe-A-eDP-1
[651.097929] Dynamic subtest pipe-A-eDP-1: FAIL (0.294s)
[651.630517] Starting dynamic subtest: pipe-B-eDP-1
[652.515988] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[652.955377] Starting dynamic subtest: pipe-C-eDP-1
[653.907512] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[654.278039] Starting dynamic subtest: pipe-D-eDP-1
[655.212789] Dynamic subtest pipe-D-eDP-1: FAIL (0.247s)
[655.215610] Subtest plane-lut1d: FAIL (4.563s)
[655.677853] [123/132] (367s left) gem_userptr_blits (readonly-pwrite-unsync)
[655.759833] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[655.911332] [124/132] (366s left) gem_close (basic)
[655.959620] Starting subtest: basic
[655.962173] Subtest basic: SUCCESS (0.000s)
[656.073435] [125/132] (366s left) kms_chamelium_color (ctm-red-to-blue)
[656.166087] Subtest ctm-red-to-blue: SKIP (0.000s)
[656.214504] [126/132] (366s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[656.445895] Starting subtest: cursor-rapid-movement-256x256
[656.451560] Starting dynamic subtest: pipe-A-eDP-1
[656.991193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[657.022406] Starting dynamic subtest: pipe-D-eDP-1
[658.161752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.156s)
[658.164387] Subtest cursor-rapid-movement-256x256: SUCCESS (1.725s)
[659.040796] [127/132] (363s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[659.158335] Starting subtest: basic-flip-after-cursor-varying-size
[660.080016] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.926s)
[660.965365] [128/132] (362s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[661.056661] Starting subtest: fbc-psr-sprite-mmap-gtt
[661.059193] Starting dynamic subtest: eDP-1
[661.064313] Dynamic subtest eDP-1: SKIP (0.000s)
[661.069524] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[661.151372] [129/132] (361s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[661.258747] Starting subtest: yf-tiled-16bpp-rotate-90
[661.263914] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[661.391549] [130/132] (361s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[661.500044] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[661.504771] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[661.630019] [131/132] (361s left) kms_prop_blob (blob-prop-lifetime)
[661.687940] Starting subtest: blob-prop-lifetime
[661.690863] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[661.816616] [132/132] (361s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[661.927356] Starting subtest: y-tiled-16bpp-rotate-270
[661.931451] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[662.030853] 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.