[546.485083] Initializing watchdogs
[546.485128]   /dev/watchdog0
[546.502536] [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]
[546.508362] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[546.510669] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[546.511060] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[546.514293] [001/132] (960s left) gem_exec_schedule (independent)
[546.614430] Starting subtest: independent
[546.616688] Starting dynamic subtest: rcs0
[548.153602] Dynamic subtest rcs0: SUCCESS (1.546s)
[548.167111] Starting dynamic subtest: vcs0
[550.211846] Dynamic subtest vcs0: SUCCESS (2.054s)
[550.224369] Starting dynamic subtest: vcs1
[552.227156] Dynamic subtest vcs1: SUCCESS (2.015s)
[552.239827] Starting dynamic subtest: vecs0
[554.191602] Dynamic subtest vecs0: SUCCESS (1.961s)
[554.204639] Starting dynamic subtest: ccs0
[556.155113] Dynamic subtest ccs0: SUCCESS (1.960s)
[556.157858] Subtest independent: SUCCESS (9.547s)
[556.467775] [002/132] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[556.609291] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[556.613859] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[556.767186] [003/132] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[556.869499] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[556.873868] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[556.990072] [004/132] (950s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[557.053117] Starting subtest: invalid-signal-one-illegal-handle
[557.055373] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[557.184047] [005/132] (950s left) gem_softpin (32b-excludes-last-page)
[557.248188] Starting subtest: 32b-excludes-last-page
[557.253456] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[557.431787] [006/132] (949s left) gem_mmap_gtt (basic-copy)
[557.501888] Subtest basic-copy: SKIP (0.000s)
[557.568044] [007/132] (949s left) kms_content_protection (atomic-dpms-hdcp14)
[557.707456] Starting subtest: atomic-dpms-hdcp14
[557.711274] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[557.871418] [008/132] (949s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[557.973669] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[564.921564] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.947s)
[565.102731] [009/132] (942s left) gem_mmap_gtt (coherency)
[565.171766] Subtest coherency: SKIP (0.000s)
[565.243540] [010/132] (942s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[565.342543] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[565.344732] Starting dynamic subtest: pipe-A-default-mode
[568.021473] Dynamic subtest pipe-A-default-mode: SUCCESS (2.679s)
[568.023937] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.681s)
[568.850892] [011/132] (938s left) kms_cursor_crc (cursor-offscreen-512x170)
[569.144653] Starting subtest: cursor-offscreen-512x170
[569.149427] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[569.333368] [012/132] (938s left) perf_pmu (busy-double-start)
[569.376279] Starting subtest: busy-double-start
[569.378154] Starting dynamic subtest: rcs0
[573.005064] Dynamic subtest rcs0: FAIL (3.576s)
[573.016664] Starting dynamic subtest: bcs0
[576.527158] Dynamic subtest bcs0: SUCCESS (3.574s)
[576.539388] Starting dynamic subtest: vcs0
[580.689368] Dynamic subtest vcs0: SUCCESS (4.160s)
[580.704377] Starting dynamic subtest: vcs1
[584.738489] Dynamic subtest vcs1: SUCCESS (4.045s)
[584.751404] Starting dynamic subtest: vecs0
[588.762577] Dynamic subtest vecs0: SUCCESS (4.021s)
[588.775182] Starting dynamic subtest: ccs0
[592.401266] Dynamic subtest ccs0: FAIL (3.564s)
[592.403457] Subtest busy-double-start: FAIL (22.951s)
[592.474542] [013/132] (915s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[592.575203] Starting subtest: fbc-rgb565-draw-pwrite
[597.220282] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.647s)
[598.456050] [014/132] (909s left) gem_tiled_pread_basic
[598.607011] [015/132] (909s left) kms_psr (fbc-psr2-cursor-plane-move)
[598.712450] Starting subtest: fbc-psr2-cursor-plane-move
[598.714677] Starting dynamic subtest: eDP-1
[598.718728] Dynamic subtest eDP-1: SKIP (0.000s)
[598.722753] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[598.810647] [016/132] (908s left) gem_render_copy (y-tiled-ccs-to-linear)
[598.884142] Starting subtest: y-tiled-ccs-to-linear
[598.888410] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[599.089633] [017/132] (908s left) kms_color (ctm-0-25)
[599.180097] Starting subtest: ctm-0-25
[599.182318] Starting dynamic subtest: pipe-A-eDP-1
[602.697989] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.519s)
[602.708343] Starting dynamic subtest: pipe-B-eDP-1
[606.872149] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.171s)
[606.882768] Starting dynamic subtest: pipe-C-eDP-1
[610.947873] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.075s)
[610.958168] Starting dynamic subtest: pipe-D-eDP-1
[614.954023] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.002s)
[614.956283] Subtest ctm-0-25: SUCCESS (15.771s)
[615.862532] [018/132] (891s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[616.418289] Starting subtest: syncobj-timeline-multiple-ext-nodes
[616.420876] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[618.310366] [019/132] (889s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[618.436548] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[618.450781] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.014s)
[618.554009] [020/132] (889s left) gem_mmap_gtt (fault-concurrent-y)
[618.618420] Subtest fault-concurrent-Y: SKIP (0.000s)
[618.701016] [021/132] (889s left) syncobj_timeline (reset-signaled)
[618.758747] Starting subtest: reset-signaled
[618.761047] Subtest reset-signaled: SUCCESS (0.000s)
[618.881079] [022/132] (889s left) kms_lease (simple-lease)
[618.978966] Starting subtest: simple-lease
[618.981382] Starting dynamic subtest: pipe-A-eDP-1
[619.476658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s)
[619.487989] Starting dynamic subtest: pipe-B-eDP-1
[620.938957] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.459s)
[620.948946] Starting dynamic subtest: pipe-C-eDP-1
[622.331316] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s)
[622.341674] Starting dynamic subtest: pipe-D-eDP-1
[623.737826] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[623.740198] Subtest simple-lease: SUCCESS (4.759s)
[624.568101] [023/132] (883s left) gem_exec_whisper (basic-queues-priority-all)
[624.642532] Starting subtest: basic-queues-priority-all
[648.467410] Subtest basic-queues-priority-all: SUCCESS (23.819s)
[648.677014] [024/132] (859s left) gem_exec_balancer (parallel-ordering)
[648.938151] Starting subtest: parallel-ordering
[649.887114] Subtest parallel-ordering: SUCCESS (0.949s)
[650.056453] [025/132] (857s left) gem_fenced_exec_thrash (too-many-fences)
[650.127183] Subtest too-many-fences: SKIP (0.000s)
[650.209970] [026/132] (857s left) kms_chamelium_frames (dp-crc-single)
[650.614121] Subtest dp-crc-single: SKIP (0.000s)
[651.414215] [027/132] (856s left) kms_big_fb (linear-16bpp-rotate-90)
[651.516030] Starting subtest: linear-16bpp-rotate-90
[651.534779] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[651.697662] [028/132] (856s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[651.792319] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[651.796572] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[651.927443] [029/132] (856s left) api_intel_bb (crc32)
[651.977284] Starting subtest: crc32
[651.979625] Starting dynamic subtest: rcs0-smem0
[652.287592] Dynamic subtest rcs0-smem0: SUCCESS (0.311s)
[652.300460] Starting dynamic subtest: bcs0-smem0
[652.616882] Dynamic subtest bcs0-smem0: SUCCESS (0.326s)
[652.628814] Starting dynamic subtest: vcs0-smem0
[652.990466] Dynamic subtest vcs0-smem0: SUCCESS (0.371s)
[653.002376] Starting dynamic subtest: vcs1-smem0
[653.406056] Dynamic subtest vcs1-smem0: SUCCESS (0.413s)
[653.419996] Starting dynamic subtest: vecs0-smem0
[653.783793] Dynamic subtest vecs0-smem0: SUCCESS (0.374s)
[653.796576] Starting dynamic subtest: ccs0-smem0
[654.127464] Dynamic subtest ccs0-smem0: SUCCESS (0.341s)
[654.130371] Subtest crc32: SUCCESS (2.152s)
[654.295476] [030/132] (853s left) kms_psr (fbc-pr-sprite-plane-onoff)
[654.398491] Starting subtest: fbc-pr-sprite-plane-onoff
[654.402797] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[654.496399] [031/132] (853s left) gem_eio (wait-1us)
[654.716539] Starting subtest: wait-1us
[655.036792] Subtest wait-1us: SUCCESS (0.321s)
[655.197394] [032/132] (853s left) kms_feature_discovery (chamelium)
[655.295249] Starting subtest: chamelium
[655.298790] Subtest chamelium: SKIP (0.000s)
[655.397320] [033/132] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[655.497414] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[655.500917] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[655.628477] [034/132] (852s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[655.716649] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[655.718510] Starting dynamic subtest: A-eDP1
[659.367603] Dynamic subtest A-eDP1: SUCCESS (3.650s)
[659.378281] Starting dynamic subtest: B-eDP1
[662.674232] Dynamic subtest B-eDP1: SUCCESS (3.305s)
[662.685375] Starting dynamic subtest: C-eDP1
[665.961733] Dynamic subtest C-eDP1: SUCCESS (3.284s)
[665.972057] Starting dynamic subtest: D-eDP1
[669.204970] Dynamic subtest D-eDP1: SUCCESS (3.243s)
[669.207164] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.491s)
[670.063152] [035/132] (838s left) i915_pciid
[670.231892] [036/132] (838s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[670.336570] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[670.338513] Starting dynamic subtest: pipe-A
[670.674686] Dynamic subtest pipe-A: SUCCESS (0.340s)
[670.685004] Starting dynamic subtest: pipe-B
[672.109453] Dynamic subtest pipe-B: SUCCESS (1.433s)
[672.120000] Starting dynamic subtest: pipe-C
[673.515726] Dynamic subtest pipe-C: SUCCESS (1.406s)
[673.529739] Starting dynamic subtest: pipe-D
[674.936940] Dynamic subtest pipe-D: SUCCESS (1.419s)
[674.939269] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.607s)
[676.158115] [037/132] (832s left) gem_exec_flush (basic-wb-ro-before-default)
[676.223086] Starting subtest: basic-wb-ro-before-default
[681.670003] Subtest basic-wb-ro-before-default: SUCCESS (5.451s)
[681.893570] [038/132] (826s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[681.998567] Starting subtest: 4-tiled-8bpp-rotate-180
[683.212211] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.214s)
[683.389831] [039/132] (825s left) kms_pipe_stress (stress-xrgb8888-untiled)
[683.515073] Starting subtest: stress-xrgb8888-untiled
[689.351662] Subtest stress-xrgb8888-untiled: SUCCESS (5.843s)
[689.401531] [040/132] (819s left) gem_exec_reloc (basic-cpu-wc-active)
[689.462501] Subtest basic-cpu-wc-active: SKIP (0.000s)
[689.545551] [041/132] (819s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[689.649644] Starting subtest: verify-pxp-key-change-after-suspend-resume
[696.875538] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.231s)
[703.052403] [042/132] (811s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[703.168930] Starting subtest: primary-yf-tiled-reflect-x-90
[703.173399] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[703.270576] [043/132] (811s left) api_intel_bb (blit-noreloc-keep-cache)
[703.326442] Starting subtest: blit-noreloc-keep-cache
[703.335898] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[703.497371] [044/132] (811s left) kms_pm_backlight (fade-with-suspend)
[703.595496] Starting subtest: fade-with-suspend
[719.520264] Starting dynamic subtest: eDP-1
[722.195605] Dynamic subtest eDP-1: SUCCESS (2.676s)
[722.198305] Subtest fade-with-suspend: SUCCESS (4.313s)
[729.068077] [045/132] (791s left) kms_addfb_basic (small-bo)
[729.187348] Starting subtest: small-bo
[729.189890] Subtest small-bo: SUCCESS (0.000s)
[729.309514] [046/132] (791s left) gem_userptr_blits (mmap-offset-banned)
[729.390987] Starting subtest: mmap-offset-banned
[729.393570] Starting dynamic subtest: wb
[729.395898] Dynamic subtest wb: SUCCESS (0.000s)
[729.406813] Starting dynamic subtest: wc
[729.408951] Dynamic subtest wc: SUCCESS (0.000s)
[729.418528] Starting dynamic subtest: uc
[729.420622] Dynamic subtest uc: SUCCESS (0.000s)
[729.422575] Subtest mmap-offset-banned: SUCCESS (0.002s)
[729.549584] [047/132] (791s left) kms_invalid_mode (zero-vdisplay)
[729.660157] Starting subtest: zero-vdisplay
[729.662519] Starting dynamic subtest: pipe-A-eDP-1
[729.945811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[729.956963] Starting dynamic subtest: pipe-B-eDP-1
[729.959240] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[729.969143] Starting dynamic subtest: pipe-C-eDP-1
[729.971134] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[729.980554] Starting dynamic subtest: pipe-D-eDP-1
[729.982516] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[729.984518] Subtest zero-vdisplay: SUCCESS (0.290s)
[730.862671] [048/132] (790s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[730.964963] Starting subtest: psr-rgb101010-draw-pwrite
[738.566985] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.574s)
[738.705828] [049/132] (782s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[738.803964] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[738.806302] Starting dynamic subtest: pipe-A-eDP-1
[738.868106] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[738.877888] Starting dynamic subtest: pipe-B-eDP-1
[738.944797] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[738.956025] Starting dynamic subtest: pipe-C-eDP-1
[739.024094] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[739.034757] Starting dynamic subtest: pipe-D-eDP-1
[739.101572] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[739.106342] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[741.098878] [050/132] (780s left) kms_cursor_crc (cursor-sliding-max-size)
[741.394058] Starting subtest: cursor-sliding-max-size
[741.401395] Subtest cursor-sliding-max-size: SKIP (0.000s)
[741.552097] [051/132] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[741.646962] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[741.652035] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[741.767150] [052/132] (779s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[741.828394] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[741.933767] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[742.033213] [053/132] (779s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[742.130173] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[742.135210] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[742.264190] [054/132] (779s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[742.361108] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[742.363781] Starting dynamic subtest: pipe-A-eDP-1
[742.389909] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[742.402347] Starting dynamic subtest: pipe-B-eDP-1
[742.427501] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[742.437351] Starting dynamic subtest: pipe-C-eDP-1
[742.463075] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[742.472888] Starting dynamic subtest: pipe-D-eDP-1
[742.498862] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[742.503983] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[744.600108] [055/132] (776s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[744.709367] Starting subtest: x-tiled-16bpp-rotate-90
[744.732015] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[744.891453] [056/132] (776s left) kms_plane (plane-panning-top-left)
[744.999874] Starting subtest: plane-panning-top-left
[745.002197] Starting dynamic subtest: pipe-A
[746.708561] Dynamic subtest pipe-A: SUCCESS (1.708s)
[746.719760] Starting dynamic subtest: pipe-B
[749.119267] Dynamic subtest pipe-B: SUCCESS (2.406s)
[749.122207] Subtest plane-panning-top-left: SUCCESS (4.117s)
[750.007661] [057/132] (771s left) kms_getfb (getfb-handle-zero)
[750.111195] Starting subtest: getfb-handle-zero
[750.114156] Subtest getfb-handle-zero: SUCCESS (0.000s)
[750.256785] [058/132] (771s left) kms_flip (dpms-vs-vblank-race-interruptible)
[750.349998] Starting subtest: dpms-vs-vblank-race-interruptible
[750.352489] Starting dynamic subtest: A-eDP1
[754.246726] Dynamic subtest A-eDP1: SUCCESS (3.893s)
[754.259051] Starting dynamic subtest: B-eDP1
[757.751950] Dynamic subtest B-eDP1: SUCCESS (3.502s)
[757.763167] Starting dynamic subtest: C-eDP1
[762.347797] Dynamic subtest C-eDP1: SUCCESS (4.588s)
[762.359039] Starting dynamic subtest: D-eDP1
[765.829520] Dynamic subtest D-eDP1: SUCCESS (3.484s)
[765.832178] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (15.475s)
[766.721856] [059/132] (754s left) kms_addfb_basic (bad-pitch-256)
[766.909487] Starting subtest: bad-pitch-256
[766.911964] Subtest bad-pitch-256: SUCCESS (0.000s)
[767.213687] [060/132] (754s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[767.350234] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[767.352859] Starting dynamic subtest: pipe-A-eDP-1
[768.227806] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.868s)
[768.244938] Starting dynamic subtest: pipe-B-eDP-1
[769.780854] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.552s)
[769.791295] Starting dynamic subtest: pipe-C-eDP-1
[771.290047] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.508s)
[771.300385] Starting dynamic subtest: pipe-D-eDP-1
[772.799485] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.508s)
[772.802107] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.442s)
[774.013541] [061/132] (747s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[774.109390] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[774.113929] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[774.241728] [062/132] (747s left) vgem_basic (busy-fence)
[774.288265] Starting subtest: busy-fence
[774.290757] Subtest busy-fence: SUCCESS (0.000s)
[774.380197] [063/132] (747s left) gem_ctx_shared (detached-shared-gtt)
[774.449651] Starting subtest: detached-shared-gtt
[776.604208] Subtest detached-shared-gtt: SUCCESS (2.153s)
[778.177887] [064/132] (743s left) kms_atomic_interruptible (legacy-dpms)
[778.304470] Starting subtest: legacy-dpms
[778.306898] Starting dynamic subtest: pipe-A-eDP-1
[785.787021] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.479s)
[785.789456] Subtest legacy-dpms: SUCCESS (7.482s)
[786.612548] [065/132] (735s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[791.659387] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[791.662331] Starting dynamic subtest: pipe-A-eDP-1
[792.429901] Dynamic subtest pipe-A-eDP-1: SKIP (0.764s)
[792.440545] Starting dynamic subtest: pipe-B-eDP-1
[793.543922] Dynamic subtest pipe-B-eDP-1: SKIP (1.112s)
[793.549207] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.881s)
[794.808877] [066/132] (727s left) kms_cursor_legacy (torture-bo)
[794.933385] Starting subtest: torture-bo
[794.935773] Starting dynamic subtest: pipe-A
[801.084378] Dynamic subtest pipe-A: SUCCESS (6.146s)
[801.097320] Starting dynamic subtest: pipe-B
[807.811993] Dynamic subtest pipe-B: SUCCESS (6.724s)
[807.825121] Starting dynamic subtest: pipe-C
[815.318489] Dynamic subtest pipe-C: SUCCESS (7.502s)
[815.335899] Starting dynamic subtest: pipe-D
[821.905590] Dynamic subtest pipe-D: SUCCESS (6.582s)
[821.918876] Starting dynamic subtest: all-pipes
[828.506578] Dynamic subtest all-pipes: SUCCESS (6.600s)
[828.509258] Subtest torture-bo: SUCCESS (33.565s)
[828.705193] [067/132] (693s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[828.815678] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[835.511183] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.700s)
[835.671613] [068/132] (686s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[835.769242] Starting subtest: fbcpsr-shrfb-scaledprimary
[841.476384] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.711s)
[841.659367] [069/132] (680s left) gem_ppgtt (shrink-vs-evict-pinned)
[841.726773] Starting subtest: shrink-vs-evict-pinned
[847.469346] Subtest shrink-vs-evict-pinned: SUCCESS (5.742s)
[847.565337] [070/132] (674s left) kms_flip (flip-vs-blocking-wf-vblank)
[847.675349] Starting subtest: flip-vs-blocking-wf-vblank
[847.678074] Starting dynamic subtest: A-eDP1
[856.599689] Dynamic subtest A-eDP1: SUCCESS (8.927s)
[856.614935] Starting dynamic subtest: B-eDP1
[865.498582] Dynamic subtest B-eDP1: SUCCESS (8.897s)
[865.509987] Starting dynamic subtest: C-eDP1
[874.391633] Dynamic subtest C-eDP1: SUCCESS (8.889s)
[874.404491] Starting dynamic subtest: D-eDP1
[883.293617] Dynamic subtest D-eDP1: SUCCESS (8.899s)
[883.296347] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.619s)
[884.497098] [071/132] (637s left) syncobj_timeline (wait-all-interrupted)
[884.558158] Starting subtest: wait-all-interrupted
[884.660362] Subtest wait-all-interrupted: SUCCESS (0.102s)
[884.774129] [072/132] (637s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[884.876878] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[891.608114] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.732s)
[891.772532] [073/132] (630s left) gem_mmap_gtt (cpuset-big-copy)
[891.841915] Subtest cpuset-big-copy: SKIP (0.000s)
[891.914114] [074/132] (630s left) kms_hdr (invalid-metadata-sizes)
[892.011370] Starting subtest: invalid-metadata-sizes
[892.018857] Subtest invalid-metadata-sizes: SKIP (0.000s)
[892.110214] [075/132] (630s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[892.204604] Starting subtest: plane-all-modeset-transition-fencing
[892.210098] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[892.311661] [076/132] (630s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[892.417744] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[899.158202] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.742s)
[899.331655] [077/132] (623s left) gem_exec_reloc (basic-concurrent16)
[899.400516] Subtest basic-concurrent16: SKIP (0.000s)
[899.474580] [078/132] (622s left) kms_pm_rpm (legacy-planes-dpms)
[901.608975] Starting subtest: legacy-planes-dpms
[901.611640] Starting dynamic subtest: plane-63
[910.195640] Dynamic subtest plane-63: SUCCESS (8.587s)
[910.209602] Starting dynamic subtest: plane-93
[918.538523] Dynamic subtest plane-93: SUCCESS (8.338s)
[918.557793] Starting dynamic subtest: plane-123
[927.114364] Dynamic subtest plane-123: SUCCESS (8.571s)
[927.126901] Starting dynamic subtest: plane-133
[935.722226] Dynamic subtest plane-133: SUCCESS (8.603s)
[935.725016] Subtest legacy-planes-dpms: SUCCESS (34.110s)
[936.110168] [079/132] (586s left) kms_selftest (drm_cmdline_parser)
[936.151274] Starting subtest: drm_cmdline_parser
[936.190253] Starting dynamic subtest: drm_test_cmdline_force_d_only
[936.330641] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.139s)
[936.342842] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[936.433151] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.102s)
[936.445580] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[936.555255] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.121s)
[936.567356] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[936.673284] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.116s)
[936.685283] Starting dynamic subtest: drm_test_cmdline_force_e_only
[936.787081] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.114s)
[936.799036] Starting dynamic subtest: drm_test_cmdline_res
[936.925255] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.136s)
[936.935971] Starting dynamic subtest: drm_test_cmdline_res_vesa
[937.059147] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.133s)
[937.071370] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[937.198005] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.137s)
[937.208864] Starting dynamic subtest: drm_test_cmdline_res_rblank
[937.299333] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.101s)
[937.310382] Starting dynamic subtest: drm_test_cmdline_res_bpp
[937.436976] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.137s)
[937.448597] Starting dynamic subtest: drm_test_cmdline_res_refresh
[937.571550] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.133s)
[937.583656] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[937.705083] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.133s)
[937.717678] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[937.807973] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.103s)
[937.818325] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[937.906872] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.099s)
[937.917154] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[938.040426] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.132s)
[938.050976] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[938.158207] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.114s)
[938.180873] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[938.310213] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.152s)
[938.321284] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[938.446081] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.136s)
[938.458951] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[938.595626] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.148s)
[938.608416] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[938.688333] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.092s)
[938.700382] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[938.803142] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.114s)
[938.815799] Starting dynamic subtest: drm_test_cmdline_name
[938.923195] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.116s)
[938.934749] Starting dynamic subtest: drm_test_cmdline_name_bpp
[939.042344] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.118s)
[939.054216] Starting dynamic subtest: drm_test_cmdline_name_option
[939.157349] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.115s)
[939.167355] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[939.274289] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.115s)
[939.285225] Starting dynamic subtest: drm_test_cmdline_rotate_0
[939.383269] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.108s)
[939.394100] Starting dynamic subtest: drm_test_cmdline_rotate_90
[939.500358] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.117s)
[939.512955] Starting dynamic subtest: drm_test_cmdline_rotate_180
[939.605633] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.106s)
[939.617606] Starting dynamic subtest: drm_test_cmdline_rotate_270
[939.734788] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.127s)
[939.746934] Starting dynamic subtest: drm_test_cmdline_hmirror
[939.831154] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.096s)
[939.841540] Starting dynamic subtest: drm_test_cmdline_vmirror
[939.981634] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.148s)
[939.993200] Starting dynamic subtest: drm_test_cmdline_margin_options
[940.108067] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.127s)
[940.119903] Starting dynamic subtest: drm_test_cmdline_multiple_options
[940.243355] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.133s)
[940.255767] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[940.374287] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.130s)
[940.386179] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[940.505239] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.130s)
[940.516852] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[940.648071] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.143s)
[940.658222] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[940.779660] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.129s)
[940.790643] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[940.911050] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.130s)
[940.921614] Starting dynamic subtest: drm_test_cmdline_invalid
[941.032189] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.119s)
[941.042751] Starting dynamic subtest: drm_test_cmdline_tv_options
[941.180978] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.146s)
[941.183137] Subtest drm_cmdline_parser: SUCCESS (5.031s)
[941.404952] [080/132] (581s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[941.505404] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[941.507954] Starting dynamic subtest: pipe-A-eDP-1
[941.531365] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[941.542096] Starting dynamic subtest: pipe-B-eDP-1
[941.565050] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[941.575151] Starting dynamic subtest: pipe-C-eDP-1
[941.598138] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[941.608127] Starting dynamic subtest: pipe-D-eDP-1
[941.631384] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[941.635562] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[943.823591] [081/132] (578s left) kms_psr (psr2-sprite-blt)
[943.917730] Starting subtest: psr2-sprite-blt
[943.920056] Starting dynamic subtest: eDP-1
[945.654089] Dynamic subtest eDP-1: SUCCESS (1.734s)
[945.656557] Subtest psr2-sprite-blt: SUCCESS (1.736s)
[946.522062] [082/132] (576s left) kms_setmode (invalid-clone-exclusive-crtc)
[946.579014] Starting subtest: invalid-clone-exclusive-crtc
[946.587146] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[946.718990] [083/132] (575s left) kms_flip_event_leak (basic)
[946.812350] Starting subtest: basic
[946.815117] Starting dynamic subtest: pipe-A-eDP-1
[947.230335] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[947.242014] Starting dynamic subtest: pipe-B-eDP-1
[948.378493] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[948.389918] Starting dynamic subtest: pipe-C-eDP-1
[949.458270] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.079s)
[949.469729] Starting dynamic subtest: pipe-D-eDP-1
[950.558200] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.096s)
[950.561196] Subtest basic: SUCCESS (3.746s)
[951.419693] [084/132] (571s left) gem_workarounds (basic-read)
[951.487169] Starting subtest: basic-read
[951.499124] Subtest basic-read: SUCCESS (0.012s)
[951.627484] [085/132] (571s left) dmabuf_sync_file (import-multiple-read-only)
[951.681346] Starting subtest: import-multiple-read-only
[951.684160] Subtest import-multiple-read-only: SUCCESS (0.003s)
[951.764760] [086/132] (571s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[951.866340] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[952.241237] Starting dynamic subtest: pipe-A-eDP-1
[955.035250] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.794s)
[955.418212] Starting dynamic subtest: pipe-B-eDP-1
[958.139936] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.735s)
[958.516043] Starting dynamic subtest: pipe-C-eDP-1
[961.239265] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.733s)
[961.613083] Starting dynamic subtest: pipe-D-eDP-1
[964.339656] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.735s)
[964.342764] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.475s)
[965.509570] [087/132] (557s left) kms_atomic (plane-overlay-legacy)
[965.608909] Starting subtest: plane-overlay-legacy
[965.611171] Starting dynamic subtest: pipe-A-eDP-1
[966.017989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.411s)
[966.020719] Subtest plane-overlay-legacy: SUCCESS (0.413s)
[966.911485] [088/132] (556s left) gem_exec_balancer (parallel-balancer)
[967.172168] Starting subtest: parallel-balancer
[968.054210] Subtest parallel-balancer: SUCCESS (0.882s)
[968.182603] [089/132] (554s left) gem_mmap_gtt (basic-write-gtt)
[968.250141] Subtest basic-write-gtt: SKIP (0.000s)
[968.313699] [090/132] (554s left) perf_pmu (render-node-busy)
[968.374902] Starting subtest: render-node-busy
[968.377509] Starting dynamic subtest: rcs0
[968.985256] Dynamic subtest rcs0: SUCCESS (0.610s)
[968.998302] Starting dynamic subtest: bcs0
[969.545367] Dynamic subtest bcs0: SUCCESS (0.558s)
[969.558383] Starting dynamic subtest: vcs0
[971.465950] Dynamic subtest vcs0: SUCCESS (1.917s)
[971.479370] Starting dynamic subtest: vcs1
[973.450296] Dynamic subtest vcs1: SUCCESS (1.982s)
[973.463532] Starting dynamic subtest: vecs0
[975.498697] Dynamic subtest vecs0: SUCCESS (2.045s)
[975.512514] Starting dynamic subtest: ccs0
[976.069920] Dynamic subtest ccs0: SUCCESS (0.569s)
[976.073155] Subtest render-node-busy: SUCCESS (7.698s)
[976.179760] [091/132] (546s left) i915_pm_rpm (system-suspend-execbuf)
[977.708211] Starting subtest: system-suspend-execbuf
[1035.937621] Subtest system-suspend-execbuf: SUCCESS (42.781s)
[1036.358468] [092/132] (486s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[1041.452639] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[1041.455175] Starting dynamic subtest: pipe-A-eDP-1
[1047.935640] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.478s)
[1047.948336] Starting dynamic subtest: pipe-B-eDP-1
[1054.432613] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.492s)
[1054.435470] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.974s)
[1055.301996] [093/132] (467s left) kms_vblank (wait-forked)
[1055.403754] Starting subtest: wait-forked
[1055.406092] Starting dynamic subtest: pipe-A-eDP-1
[1057.221559] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[1057.237619] Starting dynamic subtest: pipe-D-eDP-1
[1059.814326] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.588s)
[1059.817106] Subtest wait-forked: SUCCESS (4.411s)
[1060.701981] [094/132] (462s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[1060.814490] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[1060.819605] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[1060.953588] [095/132] (462s left) gen9_exec_parse (allowed-single)
[1061.009161] Subtest allowed-single: SKIP (0.000s)
[1061.079153] [096/132] (462s left) syncobj_eventfd (timeline-wait)
[1061.131533] Starting subtest: timeline-wait
[1061.139639] Subtest timeline-wait: SUCCESS (0.010s)
[1061.270108] [097/132] (462s left) kms_vblank (ts-continuation-modeset-rpm)
[1061.355306] Starting subtest: ts-continuation-modeset-rpm
[1061.357995] Starting dynamic subtest: pipe-A-eDP-1
[1063.840628] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.483s)
[1063.856222] Starting dynamic subtest: pipe-D-eDP-1
[1066.018618] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.174s)
[1066.021468] Subtest ts-continuation-modeset-rpm: SUCCESS (4.661s)
[1066.899921] [098/132] (456s left) sw_sync (sync_busy)
[1066.946616] Starting subtest: sync_busy
[1066.949458] Subtest sync_busy: SUCCESS (0.002s)
[1067.036006] [099/132] (456s left) gem_ctx_persistence (engines-persistence)
[1067.097011] Starting subtest: engines-persistence
[1067.099411] Starting dynamic subtest: rcs0
[1067.880835] Dynamic subtest rcs0: SUCCESS (0.786s)
[1067.894852] Starting dynamic subtest: bcs0
[1068.704642] Dynamic subtest bcs0: SUCCESS (0.821s)
[1068.718669] Starting dynamic subtest: vcs0
[1069.437746] Dynamic subtest vcs0: SUCCESS (0.730s)
[1069.450675] Starting dynamic subtest: vcs1
[1070.306907] Dynamic subtest vcs1: SUCCESS (0.866s)
[1070.320437] Starting dynamic subtest: vecs0
[1071.040945] Dynamic subtest vecs0: SUCCESS (0.731s)
[1071.053491] Starting dynamic subtest: ccs0
[1071.874016] Dynamic subtest ccs0: SUCCESS (0.830s)
[1071.876996] Subtest engines-persistence: SUCCESS (4.780s)
[1072.041243] [100/132] (451s left) syncobj_basic (bad-handle-to-fd)
[1072.105438] Starting subtest: bad-handle-to-fd
[1072.107936] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[1072.241036] [101/132] (451s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[1072.307619] Starting subtest: yf-tiled-to-vebox-x-tiled
[1072.313382] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[1072.536108] [102/132] (451s left) syncobj_timeline (invalid-wait-illegal-handle)
[1072.589540] Starting subtest: invalid-wait-illegal-handle
[1072.592005] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[1072.716311] [103/132] (450s left) i915_drm_fdinfo (memory-info-idle)
[1072.770300] Starting subtest: memory-info-idle
[1072.772383] Starting dynamic subtest: smem0
[1072.846003] Dynamic subtest smem0: SUCCESS (0.078s)
[1072.848947] Subtest memory-info-idle: SUCCESS (0.079s)
[1072.947148] [104/132] (450s left) gem_softpin (noreloc)
[1073.008345] Starting subtest: noreloc
[1078.400408] Subtest noreloc: SUCCESS (5.387s)
[1078.571204] [105/132] (445s left) i915_pm_sseu (full-enable)
[1078.632292] Subtest full-enable: SKIP (0.000s)
[1078.774069] [106/132] (444s left) gem_ctx_engines (execute-oneforall)
[1078.837658] Starting subtest: execute-oneforall
[1079.890799] Subtest execute-oneforall: SUCCESS (1.051s)
[1080.999804] [107/132] (442s left) gem_exec_whisper (basic-normal)
[1081.075543] Starting subtest: basic-normal
[1086.201628] Subtest basic-normal: SUCCESS (5.125s)
[1086.410711] [108/132] (437s left) syncobj_basic (bad-flags-handle-to-fd)
[1086.465341] Starting subtest: bad-flags-handle-to-fd
[1086.467736] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[1086.607229] [109/132] (437s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[1086.702469] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[1086.707451] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[1086.813074] [110/132] (437s left) gem_exec_schedule (thriceslice)
[1086.891393] Starting subtest: thriceslice
[1086.894028] Starting dynamic subtest: rcs0
[1086.929910] Dynamic subtest rcs0: SUCCESS (0.052s)
[1086.943669] Starting dynamic subtest: bcs0
[1086.967337] Dynamic subtest bcs0: SUCCESS (0.035s)
[1086.978631] Starting dynamic subtest: vcs0
[1087.003137] Dynamic subtest vcs0: SUCCESS (0.033s)
[1087.013944] Starting dynamic subtest: vcs1
[1087.057531] Dynamic subtest vcs1: SUCCESS (0.053s)
[1087.070445] Starting dynamic subtest: vecs0
[1087.087725] Dynamic subtest vecs0: SUCCESS (0.028s)
[1087.098614] Starting dynamic subtest: ccs0
[1087.118624] Dynamic subtest ccs0: SUCCESS (0.030s)
[1087.121620] Subtest thriceslice: SUCCESS (0.243s)
[1088.931392] [111/132] (435s left) syncobj_wait (multi-wait-submitted-signaled)
[1088.999553] Starting subtest: multi-wait-submitted-signaled
[1089.002051] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[1089.115819] [112/132] (434s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[1089.217866] Starting subtest: yf-tiled-8bpp-rotate-270
[1089.223045] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[1089.355846] [113/132] (434s left) gem_userptr_blits (access-control)
[1089.433654] Starting subtest: access-control
[1089.439079] Subtest access-control: SKIP (0.000s)
[1089.592044] [114/132] (434s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[1089.697532] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[1093.233551] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.539s)
[1094.422681] [115/132] (429s left) gem_ctx_persistence (idempotent)
[1094.491467] Starting subtest: idempotent
[1094.494506] Subtest idempotent: SUCCESS (0.000s)
[1094.656999] [116/132] (429s left) kms_flip (2x-flip-vs-fences-interruptible)
[1094.758137] Starting subtest: 2x-flip-vs-fences-interruptible
[1094.763457] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[1094.896012] [117/132] (429s left) gem_userptr_blits (map-fixed-invalidate)
[1094.956903] Starting subtest: map-fixed-invalidate
[1094.961927] Subtest map-fixed-invalidate: SKIP (0.000s)
[1095.126321] [118/132] (429s left) gem_bad_reloc (negative-reloc-lut)
[1095.192381] Subtest negative-reloc-lut: SKIP (0.000s)
[1095.253321] [119/132] (429s left) kms_fbcon_fbt (fbc-suspend)
[1095.320991] Starting subtest: fbc-suspend
[1144.668421] Subtest fbc-suspend: SUCCESS (19.940s)
[1148.980665] [120/132] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[1149.094379] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[1149.098722] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[1149.233925] [121/132] (378s left) kms_psr (psr-cursor-mmap-gtt)
[1149.335959] Starting subtest: psr-cursor-mmap-gtt
[1149.338453] Starting dynamic subtest: eDP-1
[1151.039038] Dynamic subtest eDP-1: SUCCESS (1.689s)
[1151.041415] Subtest psr-cursor-mmap-gtt: SUCCESS (1.690s)
[1151.928222] [122/132] (375s left) kms_color_pipeline (plane-lut1d)
[1152.027699] Starting subtest: plane-lut1d
[1152.040517] Starting dynamic subtest: pipe-A-eDP-1
[1152.748039] Dynamic subtest pipe-A-eDP-1: FAIL (0.294s)
[1153.451284] Starting dynamic subtest: pipe-B-eDP-1
[1154.238367] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[1154.770526] Starting dynamic subtest: pipe-C-eDP-1
[1155.639062] Dynamic subtest pipe-C-eDP-1: FAIL (0.291s)
[1156.167325] Starting dynamic subtest: pipe-D-eDP-1
[1157.027151] Dynamic subtest pipe-D-eDP-1: FAIL (0.279s)
[1157.029471] Subtest plane-lut1d: FAIL (4.696s)
[1157.644596] [123/132] (369s left) gem_userptr_blits (readonly-pwrite-unsync)
[1157.722047] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[1157.895740] [124/132] (369s left) gem_close (basic)
[1157.967245] Starting subtest: basic
[1157.969551] Subtest basic: SUCCESS (0.000s)
[1158.103525] [125/132] (369s left) kms_chamelium_color (ctm-red-to-blue)
[1158.207836] Subtest ctm-red-to-blue: SKIP (0.000s)
[1158.252717] [126/132] (369s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[1158.482487] Starting subtest: cursor-rapid-movement-256x256
[1158.484905] Starting dynamic subtest: pipe-A-eDP-1
[1159.030728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[1159.062759] Starting dynamic subtest: pipe-D-eDP-1
[1160.204353] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.150s)
[1160.206864] Subtest cursor-rapid-movement-256x256: SUCCESS (1.718s)
[1161.057836] [127/132] (366s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[1161.192079] Starting subtest: basic-flip-after-cursor-varying-size
[1162.118501] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.924s)
[1162.970526] [128/132] (364s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[1163.072849] Starting subtest: fbc-psr-sprite-mmap-gtt
[1163.075107] Starting dynamic subtest: eDP-1
[1163.079479] Dynamic subtest eDP-1: SKIP (0.000s)
[1163.083849] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[1163.173385] [129/132] (364s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[1163.280378] Starting subtest: yf-tiled-16bpp-rotate-90
[1163.284978] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[1163.406048] [130/132] (364s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[1163.509047] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[1163.513274] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[1163.630859] [131/132] (364s left) kms_prop_blob (blob-prop-lifetime)
[1163.685450] Starting subtest: blob-prop-lifetime
[1163.687551] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[1163.829086] [132/132] (364s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[1163.921229] Starting subtest: y-tiled-16bpp-rotate-270
[1163.924725] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[1164.055236] 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.