[65.793298] Initializing watchdogs
[65.793367]   /dev/watchdog0
[65.813685] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[65.825074] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[65.828983] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.831304] [001/133] (960s left) gem_madvise (dontneed-before-mmap)
[65.878198] Starting subtest: dontneed-before-mmap
[65.913130] Subtest dontneed-before-mmap: SUCCESS (0.035s)
[66.069012] [002/133] (960s left) kms_plane_alpha_blend (constant-alpha-mid)
[67.576513] Starting subtest: constant-alpha-mid
[67.908118] Starting dynamic subtest: pipe-A-HDMI-A-3
[68.576687] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.669s)
[68.583992] Starting dynamic subtest: pipe-D-HDMI-A-3
[69.280179] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.703s)
[69.281087] Subtest constant-alpha-mid: SUCCESS (1.705s)
[69.449216] [003/133] (957s left) kms_cursor_crc (cursor-offscreen-256x256)
[71.187567] Starting subtest: cursor-offscreen-256x256
[71.191907] Starting dynamic subtest: pipe-A-HDMI-A-3
[73.673474] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.481s)
[73.711865] Starting dynamic subtest: pipe-D-HDMI-A-3
[76.090063] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.385s)
[76.091053] Subtest cursor-offscreen-256x256: SUCCESS (4.903s)
[76.376987] [004/133] (950s left) kms_plane (plane-position-hole-dpms)
[77.881255] Starting subtest: plane-position-hole-dpms
[78.309954] Starting dynamic subtest: pipe-A-plane-1
[78.808667] Dynamic subtest pipe-A-plane-1: SUCCESS (0.498s)
[78.816290] Starting dynamic subtest: pipe-A-plane-2
[79.283380] Dynamic subtest pipe-A-plane-2: SUCCESS (0.475s)
[79.291522] Starting dynamic subtest: pipe-A-plane-3
[79.795182] Dynamic subtest pipe-A-plane-3: SUCCESS (0.511s)
[79.802595] Starting dynamic subtest: pipe-A-plane-4
[80.268203] Dynamic subtest pipe-A-plane-4: SUCCESS (0.473s)
[80.275444] Starting dynamic subtest: pipe-A-plane-5
[80.289298] Dynamic subtest pipe-A-plane-5: SUCCESS (0.020s)
[80.559168] Starting dynamic subtest: pipe-B-plane-1
[81.000474] Dynamic subtest pipe-B-plane-1: SUCCESS (0.449s)
[81.008389] Starting dynamic subtest: pipe-B-plane-2
[81.477142] Dynamic subtest pipe-B-plane-2: SUCCESS (0.476s)
[81.484486] Starting dynamic subtest: pipe-B-plane-3
[81.928200] Dynamic subtest pipe-B-plane-3: SUCCESS (0.451s)
[81.937020] Starting dynamic subtest: pipe-B-plane-4
[82.391471] Dynamic subtest pipe-B-plane-4: SUCCESS (0.463s)
[82.399296] Starting dynamic subtest: pipe-B-plane-5
[82.412162] Dynamic subtest pipe-B-plane-5: SUCCESS (0.019s)
[82.413103] Subtest plane-position-hole-dpms: SUCCESS (4.532s)
[82.576369] [005/133] (943s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[84.084454] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[84.086158] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[84.212884] [006/133] (942s left) i915_getparams_basic (basic-subslice-total)
[84.311972] Starting subtest: basic-subslice-total
[84.313980] Subtest basic-subslice-total: SUCCESS (0.000s)
[84.428732] [007/133] (942s left) syncobj_wait (wait-all-delayed-signal)
[84.499317] Starting subtest: wait-all-delayed-signal
[84.601124] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[84.719932] [008/133] (942s left) gen7_exec_parse (basic-rejected)
[84.798442] Subtest basic-rejected: SKIP (0.000s)
[84.869974] [009/133] (941s left) syncobj_wait (reset-unsignaled)
[84.940180] Starting subtest: reset-unsignaled
[84.941127] Subtest reset-unsignaled: SUCCESS (0.000s)
[85.123133] [010/133] (941s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[86.628190] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[86.641957] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.013s)
[86.728744] [011/133] (940s left) kms_psr2_su (page_flip-p010)
[86.819050] Subtest page_flip-P010: SKIP (0.000s)
[86.886848] [012/133] (940s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[88.394181] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[88.395896] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[88.529142] [013/133] (938s left) gem_ctx_param (invalid-param-set)
[88.628405] Starting subtest: invalid-param-set
[88.629307] Subtest invalid-param-set: SUCCESS (0.000s)
[88.805404] [014/133] (938s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[88.870953] Starting subtest: multi-wait-for-submit-submitted-signaled
[88.871906] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[89.056130] [015/133] (938s left) perf_pmu (rc6)
[89.119262] Starting subtest: rc6
[89.120180] Starting dynamic subtest: gt0
[95.469995] Dynamic subtest gt0: SUCCESS (6.349s)
[95.479547] Starting dynamic subtest: runtime-pm-gt0
[103.545237] Dynamic subtest runtime-pm-gt0: SUCCESS (8.074s)
[103.554125] Starting dynamic subtest: runtime-pm-long-gt0
[116.237331] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.693s)
[116.245531] Starting dynamic subtest: other-idle-gt0
[116.247327] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[116.248245] Subtest rc6: SUCCESS (27.122s)
[116.903891] [016/133] (910s left) syncobj_basic (bad-flags-fd-to-handle)
[116.972513] Starting subtest: bad-flags-fd-to-handle
[116.973419] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[117.057430] [017/133] (910s left) kms_psr (fbc-psr-primary-page-flip)
[118.566168] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[118.612991] [018/133] (908s left) perf (non-sampling-read-error)
[118.939121] Starting subtest: non-sampling-read-error
[118.956697] Subtest non-sampling-read-error: SUCCESS (0.018s)
[119.016242] [019/133] (908s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[120.524858] Starting subtest: fbcpsr-stridechange
[120.526505] Subtest fbcpsr-stridechange: SKIP (0.000s)
[120.598597] [020/133] (906s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[122.117054] Starting subtest: x-tiled-8bpp-rotate-90
[122.172124] Subtest x-tiled-8bpp-rotate-90: SKIP (0.054s)
[122.289694] [021/133] (905s left) gem_lmem_swapping (massive-random)
[126.594334] Starting subtest: massive-random
[126.595666] Starting dynamic subtest: lmem0
[126.726639] Dynamic subtest lmem0: SUCCESS (0.136s)
[126.727520] Subtest massive-random: SUCCESS (0.137s)
[129.674928] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true
[129.676675] [022/133] (897s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[134.473368] Starting subtest: y-tiled-16bpp-rotate-270
[134.475344] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[134.539449] [FACT kms_big_fb (y-tiled-16bpp-rotate-270)] new: kernel.kmod_is_loaded.i915: true
[134.542264] [023/133] (893s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[136.058110] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[138.144848] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.087s)
[138.276051] [024/133] (889s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[139.784744] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[139.786433] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[139.854191] [025/133] (887s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[141.378208] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[141.380303] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[141.456450] [026/133] (886s left) syncobj_wait (invalid-single-wait-unsubmitted)
[141.538025] Starting subtest: invalid-single-wait-unsubmitted
[141.538990] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[141.645566] [027/133] (886s left) perf (gen12-mi-rpc)
[141.976417] Starting subtest: gen12-mi-rpc
[141.977264] Starting dynamic subtest: rcs0
[142.032734] Dynamic subtest rcs0: SUCCESS (0.056s)
[142.033591] Subtest gen12-mi-rpc: SUCCESS (0.057s)
[142.086429] [028/133] (885s left) gem_exec_params (dr4-dirt)
[142.199068] Starting subtest: DR4-dirt
[142.200194] Subtest DR4-dirt: SUCCESS (0.000s)
[142.292683] [029/133] (885s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[143.801829] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[143.803395] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[143.871265] [030/133] (884s left) kms_big_fb (linear-64bpp-rotate-90)
[145.405665] Starting subtest: linear-64bpp-rotate-90
[145.477204] Subtest linear-64bpp-rotate-90: SKIP (0.071s)
[145.603409] [031/133] (882s left) kms_psr (pr-primary-mmap-gtt)
[147.108077] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[147.165558] [032/133] (880s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[148.673161] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[148.733011] [033/133] (879s left) gem_softpin (overlap)
[148.812523] Starting subtest: overlap
[151.931410] Subtest overlap: SUCCESS (3.119s)
[152.021633] [034/133] (876s left) kms_chamelium_color (ctm-limited-range)
[153.524998] Subtest ctm-limited-range: SKIP (0.000s)
[153.582330] [035/133] (874s left) gem_bad_reloc (negative-reloc-bltcopy)
[153.667844] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[153.774403] [036/133] (874s left) perf_pmu (most-busy-idle-check-all)
[153.839303] Starting subtest: most-busy-idle-check-all
[153.840221] Starting dynamic subtest: rcs0
[154.543774] Dynamic subtest rcs0: SUCCESS (0.704s)
[154.556692] Starting dynamic subtest: bcs0
[155.201938] Dynamic subtest bcs0: SUCCESS (0.656s)
[155.215787] Starting dynamic subtest: vcs0
[155.861813] Dynamic subtest vcs0: SUCCESS (0.658s)
[155.874856] Starting dynamic subtest: vcs1
[156.519847] Dynamic subtest vcs1: SUCCESS (0.656s)
[156.532805] Starting dynamic subtest: vecs0
[157.178651] Dynamic subtest vecs0: SUCCESS (0.657s)
[157.188228] Starting dynamic subtest: vecs1
[157.831218] Dynamic subtest vecs1: SUCCESS (0.652s)
[157.843151] Starting dynamic subtest: ccs0
[158.485811] Dynamic subtest ccs0: SUCCESS (0.654s)
[158.486863] Subtest most-busy-idle-check-all: SUCCESS (4.647s)
[158.589679] [037/133] (869s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[160.093118] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[160.170824] [038/133] (868s left) gem_pxp (fail-invalid-protected-context)
[162.782144] Starting subtest: fail-invalid-protected-context
[162.784961] Subtest fail-invalid-protected-context: SKIP (0.000s)
[162.835404] [039/133] (865s left) gem_fence_thrash (bo-write-verify-y)
[162.879577] Starting subtest: bo-write-verify-y
[162.910830] Subtest bo-write-verify-y: SKIP (0.030s)
[162.984174] [040/133] (865s left) gem_exec_flush (basic-batch-kernel-default-wb)
[163.062033] Subtest basic-batch-kernel-default-wb: SKIP (0.000s)
[163.132121] [041/133] (865s left) gem_softpin (evict-single-offset)
[163.210782] Starting subtest: evict-single-offset
[192.596970] Subtest evict-single-offset: SUCCESS (29.388s)
[192.650948] [042/133] (835s left) i915_pm_rpm (gem-pread)
[197.039783] Starting subtest: gem-pread
[198.378247] Subtest gem-pread: SUCCESS (1.338s)
[198.581992] [043/133] (830s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[200.600458] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[200.601288] Starting dynamic subtest: pipe-A-HDMI-A-3
[200.609442] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[200.619410] Starting dynamic subtest: pipe-B-HDMI-A-3
[200.627896] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[200.637700] Starting dynamic subtest: pipe-C-HDMI-A-3
[200.646132] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[200.655999] Starting dynamic subtest: pipe-D-HDMI-A-3
[200.664550] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[200.666529] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[200.808111] [044/133] (827s left) core_auth (getclient-master-drop)
[200.852166] Starting subtest: getclient-master-drop
[200.891034] Subtest getclient-master-drop: SUCCESS (0.039s)
[200.966474] [045/133] (827s left) api_intel_bb (blit-noreloc-purge-cache)
[201.036353] Starting subtest: blit-noreloc-purge-cache
[201.071476] Subtest blit-noreloc-purge-cache: SUCCESS (0.035s)
[201.170084] [046/133] (827s left) syncobj_timeline (single-wait-available-submitted)
[201.249195] Starting subtest: single-wait-available-submitted
[201.250489] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[201.300267] [047/133] (827s left) gem_exec_balancer (parallel-balancer)
[201.703230] Starting subtest: parallel-balancer
[203.325536] Subtest parallel-balancer: SUCCESS (1.619s)
[203.400439] [048/133] (825s left) gen9_exec_parse (valid-registers)
[203.476261] Subtest valid-registers: SKIP (0.000s)
[203.547215] [049/133] (825s left) prime_self_import (basic-with_fd_dup)
[203.590785] Starting subtest: basic-with_fd_dup
[203.629234] Subtest basic-with_fd_dup: SUCCESS (0.039s)
[203.706866] [050/133] (825s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[205.222674] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[205.224426] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[205.303975] [051/133] (823s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[206.863936] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[206.959836] [052/133] (822s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[208.473510] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[211.330864] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.857s)
[211.473614] [053/133] (817s left) kms_flip (2x-busy-flip)
[212.985318] Starting subtest: 2x-busy-flip
[212.997895] Subtest 2x-busy-flip: SKIP (0.013s)
[213.057967] [054/133] (816s left) gem_softpin (noreloc)
[213.135466] Starting subtest: noreloc
[218.572090] Subtest noreloc: SUCCESS (5.437s)
[218.657703] [055/133] (810s left) kms_psr (psr-primary-page-flip)
[220.161388] Subtest psr-primary-page-flip: SKIP (0.000s)
[220.221229] [056/133] (809s left) gem_render_copy (y-tiled-ccs-to-linear)
[220.299933] Starting subtest: y-tiled-ccs-to-linear
[220.302362] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[220.501721] [057/133] (808s left) gem_mmap_gtt (basic-copy)
[220.571025] Subtest basic-copy: SKIP (0.000s)
[220.653229] [058/133] (808s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[222.154503] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[222.156250] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[222.207975] [059/133] (807s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[223.715464] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[223.717110] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[223.793177] [060/133] (805s left) i915_suspend (sysfs-reader)
[223.882402] Starting subtest: sysfs-reader
[244.761660] Subtest sysfs-reader: SUCCESS (5.838s)
[249.945990] [061/133] (784s left) gem_exec_schedule (preempt-user)
[250.033810] Starting subtest: preempt-user
[250.034712] Starting dynamic subtest: rcs0
[250.109024] Dynamic subtest rcs0: SUCCESS (0.075s)
[250.121576] Starting dynamic subtest: bcs0
[250.146789] Dynamic subtest bcs0: SUCCESS (0.037s)
[250.159184] Starting dynamic subtest: vcs0
[250.186049] Dynamic subtest vcs0: SUCCESS (0.038s)
[250.198352] Starting dynamic subtest: vcs1
[250.225134] Dynamic subtest vcs1: SUCCESS (0.038s)
[250.237744] Starting dynamic subtest: vecs0
[250.265178] Dynamic subtest vecs0: SUCCESS (0.039s)
[250.278324] Starting dynamic subtest: vecs1
[250.306171] Dynamic subtest vecs1: SUCCESS (0.039s)
[250.318754] Starting dynamic subtest: ccs0
[250.344387] Dynamic subtest ccs0: SUCCESS (0.036s)
[250.345338] Subtest preempt-user: SUCCESS (0.308s)
[250.693822] [062/133] (784s left) gem_mmap_offset (mmap-boundaries)
[250.766902] Starting subtest: mmap-boundaries
[250.767615] Starting dynamic subtest: lmem0
[250.901082] Dynamic subtest lmem0: SUCCESS (0.131s)
[250.913581] Starting dynamic subtest: smem0
[252.300184] Dynamic subtest smem0: SUCCESS (1.362s)
[252.301510] Subtest mmap-boundaries: SUCCESS (1.495s)
[252.539441] [063/133] (782s left) gem_ctx_shared (single-timeline)
[252.630393] Starting subtest: single-timeline
[252.669989] Subtest single-timeline: SUCCESS (0.038s)
[252.930929] [064/133] (781s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[254.473505] Starting subtest: plane-lut1d-ctm3x4-lut1d
[254.687685] Starting dynamic subtest: pipe-A-plane-0
[254.924818] Dynamic subtest pipe-A-plane-0: SUCCESS (0.233s)
[254.969562] Starting dynamic subtest: pipe-A-plane-1
[255.126800] Dynamic subtest pipe-A-plane-1: SUCCESS (0.197s)
[255.139563] Starting dynamic subtest: pipe-A-plane-2
[255.297494] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[255.599613] Starting dynamic subtest: pipe-B-plane-0
[255.761135] Dynamic subtest pipe-B-plane-0: SUCCESS (0.198s)
[255.774383] Starting dynamic subtest: pipe-B-plane-1
[255.930476] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[255.953026] Starting dynamic subtest: pipe-B-plane-2
[256.117720] Dynamic subtest pipe-B-plane-2: SUCCESS (0.183s)
[256.460046] Starting dynamic subtest: pipe-C-plane-0
[256.622620] Dynamic subtest pipe-C-plane-0: SUCCESS (0.198s)
[256.635091] Starting dynamic subtest: pipe-C-plane-1
[256.809909] Dynamic subtest pipe-C-plane-1: SUCCESS (0.183s)
[256.850286] Starting dynamic subtest: pipe-C-plane-2
[257.012555] Dynamic subtest pipe-C-plane-2: SUCCESS (0.197s)
[257.327521] Starting dynamic subtest: pipe-D-plane-0
[257.483725] Dynamic subtest pipe-D-plane-0: SUCCESS (0.181s)
[257.496335] Starting dynamic subtest: pipe-D-plane-1
[257.653835] Dynamic subtest pipe-D-plane-1: SUCCESS (0.167s)
[257.691385] Starting dynamic subtest: pipe-D-plane-2
[257.873232] Dynamic subtest pipe-D-plane-2: SUCCESS (0.214s)
[257.911137] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (3.388s)
[258.040194] [065/133] (776s left) syncobj_basic (bad-fd-to-handle)
[258.109524] Starting subtest: bad-fd-to-handle
[258.110416] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[258.192874] [066/133] (776s left) kms_getfb (getfb2-handle-not-fb)
[259.718092] Starting subtest: getfb2-handle-not-fb
[259.719053] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[259.890659] [067/133] (775s left) gem_exec_balancer (semaphore)
[259.973641] Starting subtest: semaphore
[261.642454] Subtest semaphore: SUCCESS (1.656s)
[262.023489] [068/133] (773s left) gem_exec_schedule (lateslice)
[262.104659] Starting subtest: lateslice
[262.105577] Starting dynamic subtest: rcs0
[262.154153] Dynamic subtest rcs0: SUCCESS (0.049s)
[262.166738] Starting dynamic subtest: bcs0
[262.176809] Dynamic subtest bcs0: SUCCESS (0.022s)
[262.189704] Starting dynamic subtest: vcs0
[262.197248] Dynamic subtest vcs0: SUCCESS (0.019s)
[262.209817] Starting dynamic subtest: vcs1
[262.219041] Dynamic subtest vcs1: SUCCESS (0.021s)
[262.231735] Starting dynamic subtest: vecs0
[262.241704] Dynamic subtest vecs0: SUCCESS (0.022s)
[262.254353] Starting dynamic subtest: vecs1
[262.263297] Dynamic subtest vecs1: SUCCESS (0.021s)
[262.275910] Starting dynamic subtest: ccs0
[262.286614] Dynamic subtest ccs0: SUCCESS (0.022s)
[262.287642] Subtest lateslice: SUCCESS (0.181s)
[262.646576] [069/133] (772s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[264.158548] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[264.160949] Starting dynamic subtest: pipe-A-HDMI-A-3
[264.182796] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.002s)
[264.195513] Starting dynamic subtest: pipe-B-HDMI-A-3
[264.217859] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.002s)
[264.230098] Starting dynamic subtest: pipe-C-HDMI-A-3
[264.255049] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.002s)
[264.267026] Starting dynamic subtest: pipe-D-HDMI-A-3
[264.288427] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.002s)
[264.290068] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.014s)
[264.353520] [070/133] (770s left) kms_joiner (basic-max-non-joiner)
[265.890101] Starting subtest: basic-max-non-joiner
[265.891724] Subtest basic-max-non-joiner: SKIP (0.000s)
[265.941766] [071/133] (769s left) kms_draw_crc (draw-method-render)
[267.452102] Starting subtest: draw-method-render
[267.453055] Starting dynamic subtest: xrgb8888-untiled
[267.852657] Dynamic subtest xrgb8888-untiled: SUCCESS (0.399s)
[267.897597] Starting dynamic subtest: rgb565-untiled
[268.205900] Dynamic subtest rgb565-untiled: SUCCESS (0.349s)
[268.248908] Starting dynamic subtest: xrgb2101010-untiled
[268.503578] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.294s)
[268.518812] Starting dynamic subtest: xbgr16161616f-untiled
[268.821365] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.316s)
[268.834541] Starting dynamic subtest: xrgb8888-xtiled
[268.973111] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.150s)
[269.018839] Starting dynamic subtest: rgb565-xtiled
[269.156884] Dynamic subtest rgb565-xtiled: SUCCESS (0.180s)
[269.203231] Starting dynamic subtest: xrgb2101010-xtiled
[269.340551] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.180s)
[269.384123] Starting dynamic subtest: xbgr16161616f-xtiled
[269.523663] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.180s)
[269.539620] Starting dynamic subtest: xrgb8888-4tiled
[269.691683] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[269.736360] Starting dynamic subtest: rgb565-4tiled
[269.875749] Dynamic subtest rgb565-4tiled: SUCCESS (0.180s)
[269.914713] Starting dynamic subtest: xrgb2101010-4tiled
[270.042478] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.163s)
[270.089450] Starting dynamic subtest: xbgr16161616f-4tiled
[270.226046] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.180s)
[270.227332] Subtest draw-method-render: SUCCESS (2.767s)
[270.385672] [072/133] (765s left) gem_ctx_persistence (heartbeat-stop)
[270.467563] Starting subtest: heartbeat-stop
[270.469596] Subtest heartbeat-stop: SKIP (0.000s)
[270.559066] [073/133] (764s left) gem_fenced_exec_thrash (too-many-fences)
[270.637534] Subtest too-many-fences: SKIP (0.000s)
[270.725657] [074/133] (764s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[271.458330] Starting subtest: syncobj-timeline-multiple-ext-nodes
[271.459625] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.002s)
[271.718905] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[271.721538] [075/133] (763s left) kms_rotation_crc (primary-rotation-90)
[273.236575] Starting subtest: primary-rotation-90
[273.238366] Subtest primary-rotation-90: SKIP (0.001s)
[273.300275] [076/133] (762s left) gem_wait (await)
[273.395929] Starting subtest: await
[273.396786] Starting dynamic subtest: all-engines
[274.508722] Dynamic subtest all-engines: SUCCESS (1.110s)
[274.525807] Starting dynamic subtest: rcs0
[275.566887] Dynamic subtest rcs0: SUCCESS (1.054s)
[275.585728] Starting dynamic subtest: bcs0
[276.630936] Dynamic subtest bcs0: SUCCESS (1.059s)
[276.647622] Starting dynamic subtest: vcs0
[277.691798] Dynamic subtest vcs0: SUCCESS (1.056s)
[277.708722] Starting dynamic subtest: vcs1
[278.751220] Dynamic subtest vcs1: SUCCESS (1.054s)
[278.769440] Starting dynamic subtest: vecs0
[279.810536] Dynamic subtest vecs0: SUCCESS (1.055s)
[279.828617] Starting dynamic subtest: vecs1
[280.871077] Dynamic subtest vecs1: SUCCESS (1.057s)
[280.892526] Starting dynamic subtest: ccs0
[281.935097] Dynamic subtest ccs0: SUCCESS (1.060s)
[281.937377] Subtest await: SUCCESS (8.530s)
[282.175581] [077/133] (753s left) kms_cursor_crc (cursor-sliding-64x64)
[283.833699] Starting subtest: cursor-sliding-64x64
[283.838319] Starting dynamic subtest: pipe-A-HDMI-A-3
[288.236934] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.396s)
[288.275612] Starting dynamic subtest: pipe-D-HDMI-A-3
[292.565319] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.299s)
[292.566203] Subtest cursor-sliding-64x64: SUCCESS (8.727s)
[292.922363] [078/133] (742s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[294.445912] Starting subtest: psr-rgb101010-draw-mmap-cpu
[294.447518] Subtest psr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[294.520805] [079/133] (741s left) syncobj_timeline (etime-single-wait-all-submitted)
[294.610082] Starting subtest: etime-single-wait-all-submitted
[294.714137] Subtest etime-single-wait-all-submitted: SUCCESS (0.103s)
[294.837086] [080/133] (741s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[296.355094] Starting subtest: fbc-rgb101010-draw-mmap-wc
[296.357117] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[296.440991] [081/133] (739s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[300.020280] Starting subtest: dpms-mode-unset-lpsp
[300.956625] Subtest dpms-mode-unset-lpsp: SKIP (0.938s)
[301.279317] [082/133] (734s left) gem_basic (multigpu-create-close)
[301.360060] Starting subtest: multigpu-create-close
[301.361435] Subtest multigpu-create-close: SKIP (0.000s)
[301.995843] [083/133] (734s left) dmabuf_sync_file (import-basic)
[302.063522] Starting subtest: import-basic
[302.065631] Subtest import-basic: SUCCESS (0.002s)
[302.121816] [084/133] (734s left) gem_eio (wait-10ms)
[302.420710] Starting subtest: wait-10ms
[303.054582] Subtest wait-10ms: SUCCESS (0.634s)
[304.547947] [085/133] (731s left) kms_vblank (ts-continuation-dpms-rpm)
[306.066133] Starting subtest: ts-continuation-dpms-rpm
[306.067070] Starting dynamic subtest: pipe-A-HDMI-A-3
[308.365723] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.298s)
[308.381588] Starting dynamic subtest: pipe-D-HDMI-A-3
[310.437503] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.067s)
[310.438414] Subtest ts-continuation-dpms-rpm: SUCCESS (4.371s)
[310.568565] [086/133] (725s left) kms_cursor_crc (cursor-random-512x512)
[312.373561] Starting subtest: cursor-random-512x512
[312.375382] Subtest cursor-random-512x512: SKIP (0.001s)
[312.567536] [087/133] (723s left) gem_exec_params (no-blt)
[312.655440] Starting subtest: no-blt
[312.657570] Subtest no-blt: SUCCESS (0.001s)
[312.742300] [088/133] (723s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[314.268385] Starting subtest: yf-tiled-32bpp-rotate-180
[314.270337] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[314.366187] [089/133] (722s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[318.128677] Starting subtest: modeset-non-lpsp-stress-no-wait
[323.208440] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (5.081s)
[323.349299] [090/133] (713s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[324.873216] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[324.940024] [091/133] (711s left) gem_exec_reloc (basic-cpu-wc)
[325.028943] Subtest basic-cpu-wc: SKIP (0.000s)
[325.108479] [092/133] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[326.625106] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[326.626820] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[326.714701] [093/133] (709s left) syncobj_eventfd (binary-wait)
[326.808630] Starting subtest: binary-wait
[326.819348] Subtest binary-wait: SUCCESS (0.011s)
[326.876654] [094/133] (709s left) kms_rotation_crc (sprite-rotation-180)
[328.396346] Starting subtest: sprite-rotation-180
[338.725096] Subtest sprite-rotation-180: SUCCESS (10.325s)
[338.916670] [095/133] (697s left) kms_psr (fbc-psr2-primary-page-flip)
[340.428601] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[340.496041] [096/133] (696s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[342.013199] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[342.014115] Starting dynamic subtest: pipe-A-valid-mode
[343.531123] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.517s)
[343.532096] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.519s)
[343.692922] [097/133] (693s left) gem_ctx_persistence (engines-hang)
[343.783727] Starting subtest: engines-hang
[343.784633] Starting dynamic subtest: rcs0
[343.878427] Dynamic subtest rcs0: SUCCESS (0.094s)
[343.895276] Starting dynamic subtest: bcs0
[343.963771] Dynamic subtest bcs0: SUCCESS (0.084s)
[343.983580] Starting dynamic subtest: vcs0
[344.064315] Dynamic subtest vcs0: SUCCESS (0.097s)
[344.115019] Starting dynamic subtest: vcs1
[344.129596] Dynamic subtest vcs1: SUCCESS (0.061s)
[344.150223] Starting dynamic subtest: vecs0
[344.219645] Dynamic subtest vecs0: SUCCESS (0.088s)
[344.259620] Starting dynamic subtest: vecs1
[344.277574] Dynamic subtest vecs1: SUCCESS (0.056s)
[344.300461] Starting dynamic subtest: ccs0
[344.373346] Dynamic subtest ccs0: SUCCESS (0.093s)
[344.379137] Subtest engines-hang: SUCCESS (0.591s)
[344.541313] [098/133] (692s left) gem_ctx_engines (execute-one)
[344.632588] Starting subtest: execute-one
[348.156383] Subtest execute-one: SUCCESS (3.527s)
[348.417121] [099/133] (688s left) gem_lmem_swapping (verify)
[352.830347] Starting subtest: verify
[352.831219] Starting dynamic subtest: lmem0
[388.500210] Dynamic subtest lmem0: SUCCESS (35.680s)
[388.501255] Subtest verify: SUCCESS (35.682s)
[389.769864] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[389.771183] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[389.773260] [100/133] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[394.605341] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[394.607051] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[394.687081] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[394.689662] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[394.692836] [101/133] (642s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[396.237052] Starting subtest: 4-tiled-16bpp-rotate-90
[396.326360] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.088s)
[396.495078] [102/133] (640s left) gem_pipe_control_store_loop (reused-buffer)
[396.587982] Starting subtest: reused-buffer
[398.766123] Subtest reused-buffer: SUCCESS (2.178s)
[398.871957] [103/133] (638s left) kms_flip (2x-flip-vs-wf_vblank)
[400.840505] Starting subtest: 2x-flip-vs-wf_vblank
[400.854126] Subtest 2x-flip-vs-wf_vblank: SKIP (0.013s)
[400.924427] [104/133] (636s left) kms_flip (2x-plain-flip-ts-check)
[402.440198] Starting subtest: 2x-plain-flip-ts-check
[402.452602] Subtest 2x-plain-flip-ts-check: SKIP (0.013s)
[402.524499] [105/133] (634s left) gem_pxp (reject-modify-context-protection-off-1)
[405.140416] Starting subtest: reject-modify-context-protection-off-1
[405.142460] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[405.209361] [106/133] (632s left) gem_exec_whisper (basic-contexts-forked)
[405.300116] Starting subtest: basic-contexts-forked
[427.868706] Subtest basic-contexts-forked: SUCCESS (22.562s)
[428.035968] [107/133] (609s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[429.548277] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[429.549120] Starting dynamic subtest: pipe-A
[429.646525] Dynamic subtest pipe-A: SUCCESS (0.098s)
[429.668674] Starting dynamic subtest: pipe-B
[429.809770] Dynamic subtest pipe-B: SUCCESS (0.162s)
[429.828334] Starting dynamic subtest: pipe-C
[429.934398] Dynamic subtest pipe-C: SUCCESS (0.123s)
[429.948123] Starting dynamic subtest: pipe-D
[430.058512] Dynamic subtest pipe-D: SUCCESS (0.123s)
[430.059434] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.511s)
[430.219729] [108/133] (607s left) kms_chamelium_frames (hdmi-crc-multiple)
[431.776562] Subtest hdmi-crc-multiple: SKIP (0.000s)
[431.883627] [109/133] (605s left) kms_async_flips (crc)
[433.400399] Starting subtest: crc
[433.642729] Starting dynamic subtest: pipe-A-HDMI-A-3
[436.020689] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.377s)
[436.192494] Starting dynamic subtest: pipe-B-HDMI-A-3
[438.368352] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.187s)
[438.519863] Starting dynamic subtest: pipe-C-HDMI-A-3
[440.678397] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.169s)
[440.839516] Starting dynamic subtest: pipe-D-HDMI-A-3
[443.014687] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.186s)
[443.015656] Subtest crc: SUCCESS (9.614s)
[443.318911] [110/133] (594s left) syncobj_timeline (invalid-transfer-bad-pad)
[443.408592] Starting subtest: invalid-transfer-bad-pad
[443.409732] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[443.535050] [111/133] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[445.055260] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[445.057066] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[445.133384] [112/133] (592s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[446.666198] Starting subtest: primary-y-tiled-reflect-x-270
[446.668075] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[446.734720] [113/133] (591s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[448.260423] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[448.262138] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[448.357384] [114/133] (589s left) kms_async_flips (test-cursor)
[449.887299] Starting subtest: test-cursor
[450.129481] Starting dynamic subtest: pipe-A-HDMI-A-3
[450.406467] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.276s)
[450.609208] Starting dynamic subtest: pipe-B-HDMI-A-3
[450.667082] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.069s)
[450.852031] Starting dynamic subtest: pipe-C-HDMI-A-3
[450.918290] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.077s)
[451.098633] Starting dynamic subtest: pipe-D-HDMI-A-3
[451.156335] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.069s)
[451.157215] Subtest test-cursor: SUCCESS (1.271s)
[451.475392] [115/133] (586s left) kms_flip (dpms-vs-vblank-race)
[452.987027] Starting subtest: dpms-vs-vblank-race
[452.992328] Starting dynamic subtest: A-HDMI-A3
[456.072611] Dynamic subtest A-HDMI-A3: SUCCESS (3.078s)
[456.087496] Starting dynamic subtest: B-HDMI-A3
[459.042494] Dynamic subtest B-HDMI-A3: SUCCESS (2.967s)
[459.057364] Starting dynamic subtest: C-HDMI-A3
[462.043655] Dynamic subtest C-HDMI-A3: SUCCESS (2.999s)
[462.058642] Starting dynamic subtest: D-HDMI-A3
[465.091672] Dynamic subtest D-HDMI-A3: SUCCESS (3.045s)
[465.092602] Subtest dpms-vs-vblank-race: SUCCESS (12.102s)
[465.264070] [116/133] (572s left) kms_psr (psr2-sprite-render)
[466.784128] Subtest psr2-sprite-render: SKIP (0.000s)
[466.843968] [117/133] (571s left) kms_content_protection (legacy)
[468.423963] Starting subtest: legacy
[468.428072] Subtest legacy: SKIP (0.002s)
[468.559999] [118/133] (569s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[468.648742] Starting subtest: yf-tiled-to-vebox-yf-tiled
[468.650605] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[468.825377] [119/133] (569s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[470.344331] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[470.345263] Starting dynamic subtest: pipe-A-HDMI-A-3
[470.348946] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[470.361635] Starting dynamic subtest: pipe-B-HDMI-A-3
[470.365264] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[470.377683] Starting dynamic subtest: pipe-C-HDMI-A-3
[470.381262] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[470.393113] Starting dynamic subtest: pipe-D-HDMI-A-3
[470.396751] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[470.398777] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[470.574308] [120/133] (567s left) kms_lease (lease-revoke)
[472.092381] Starting subtest: lease-revoke
[472.093310] Starting dynamic subtest: pipe-A-HDMI-A-3
[472.170120] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.078s)
[472.184905] Starting dynamic subtest: pipe-B-HDMI-A-3
[472.221032] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.049s)
[472.236277] Starting dynamic subtest: pipe-C-HDMI-A-3
[472.269701] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.045s)
[472.282547] Starting dynamic subtest: pipe-D-HDMI-A-3
[472.315744] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.046s)
[472.316633] Subtest lease-revoke: SUCCESS (0.226s)
[472.466623] [121/133] (565s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[472.547718] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[472.649691] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[472.743996] [122/133] (565s left) kms_plane_multiple (2x-tiling-x)
[474.256397] Starting subtest: 2x-tiling-x
[474.258195] Subtest 2x-tiling-x: SKIP (0.000s)
[474.312513] [123/133] (564s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[475.830317] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[475.832027] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[475.913720] [124/133] (562s left) prime_busy (before-wait)
[476.001946] Starting subtest: before-wait
[476.007554] Starting dynamic subtest: rcs0
[476.056752] Dynamic subtest rcs0: SUCCESS (0.049s)
[476.071335] Starting dynamic subtest: bcs0
[476.106936] Dynamic subtest bcs0: SUCCESS (0.049s)
[476.125301] Starting dynamic subtest: vcs0
[476.148377] Dynamic subtest vcs0: SUCCESS (0.040s)
[476.167452] Starting dynamic subtest: vcs1
[476.189737] Dynamic subtest vcs1: SUCCESS (0.040s)
[476.208123] Starting dynamic subtest: vecs0
[476.230315] Dynamic subtest vecs0: SUCCESS (0.039s)
[476.248711] Starting dynamic subtest: vecs1
[476.269788] Dynamic subtest vecs1: SUCCESS (0.038s)
[476.289950] Starting dynamic subtest: ccs0
[476.310636] Dynamic subtest ccs0: SUCCESS (0.039s)
[476.424374] Subtest before-wait: SUCCESS (0.421s)
[476.525920] [125/133] (562s left) kms_sequence (queue-idle)
[478.042315] Starting subtest: queue-idle
[478.043233] Starting dynamic subtest: pipe-A-HDMI-A-3
[480.402091] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.359s)
[480.415364] Starting dynamic subtest: pipe-B-HDMI-A-3
[482.599082] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.195s)
[482.612723] Starting dynamic subtest: pipe-C-HDMI-A-3
[484.796850] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.196s)
[484.809967] Starting dynamic subtest: pipe-D-HDMI-A-3
[486.999090] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.201s)
[487.000007] Subtest queue-idle: SUCCESS (8.958s)
[487.128656] [126/133] (551s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[488.643257] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[488.645075] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[488.736936] [127/133] (550s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[490.269940] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[490.284308] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.013s)
[490.344014] [128/133] (548s left) gem_eio (in-flight-1us)
[490.691093] Starting subtest: in-flight-1us
[495.879905] Subtest in-flight-1us: SUCCESS (5.191s)
[497.379197] [129/133] (541s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[498.892327] Starting subtest: crc-primary-basic-yf-tiled-ccs
[498.893273] Starting dynamic subtest: pipe-A-HDMI-A-3
[498.901679] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[498.915151] Starting dynamic subtest: pipe-B-HDMI-A-3
[498.923550] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[498.936665] Starting dynamic subtest: pipe-C-HDMI-A-3
[498.945079] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[498.958291] Starting dynamic subtest: pipe-D-HDMI-A-3
[498.966632] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[498.968532] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.010s)
[499.120332] [130/133] (539s left) sysfs_heartbeat_interval (invalid)
[499.203937] Starting subtest: invalid
[499.206292] Starting dynamic subtest: vecs0
[499.207275] Dynamic subtest vecs0: SUCCESS (0.000s)
[499.221809] Starting dynamic subtest: ccs0
[499.222688] Dynamic subtest ccs0: SUCCESS (0.000s)
[499.235812] Starting dynamic subtest: vcs0
[499.236958] Dynamic subtest vcs0: SUCCESS (0.000s)
[499.250382] Starting dynamic subtest: bcs0
[499.251637] Dynamic subtest bcs0: SUCCESS (0.000s)
[499.264628] Starting dynamic subtest: vecs1
[499.265759] Dynamic subtest vecs1: SUCCESS (0.000s)
[499.278722] Starting dynamic subtest: rcs0
[499.279926] Dynamic subtest rcs0: SUCCESS (0.000s)
[499.292897] Starting dynamic subtest: vcs1
[499.294028] Dynamic subtest vcs1: SUCCESS (0.000s)
[499.295218] Subtest invalid: SUCCESS (0.011s)
[499.344655] [131/133] (539s left) syncobj_wait (invalid-wait-illegal-handle)
[499.427527] Starting subtest: invalid-wait-illegal-handle
[499.428419] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[499.513380] [132/133] (539s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[501.026431] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[501.028295] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[501.092778] [133/133] (538s left) gem_exec_parallel (engines)
[501.180354] Starting subtest: engines
[501.181271] Starting dynamic subtest: basic
[502.732328] Dynamic subtest basic: SUCCESS (1.551s)
[502.752598] Starting dynamic subtest: contexts
[506.755423] Dynamic subtest contexts: SUCCESS (4.021s)
[506.769292] Starting dynamic subtest: fds
[510.677803] Dynamic subtest fds: SUCCESS (3.921s)
[510.691666] Starting dynamic subtest: userptr
[512.160348] Dynamic subtest userptr: SUCCESS (1.482s)
[512.161440] Subtest engines: SUCCESS (10.981s)
[512.422508] Closing watchdogs
results: parsing output: 0/ for test: gem_madvise
results: parsing output: 1/ for test: kms_plane_alpha_blend
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_getparams_basic
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: gen7_exec_parse
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_psr2_su
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_ctx_param
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: syncobj_basic
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_lmem_swapping
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: perf
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: gem_softpin
results: parsing output: 33/ for test: kms_chamelium_color
results: parsing output: 34/ for test: gem_bad_reloc
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: gem_fence_thrash
results: parsing output: 39/ for test: gem_exec_flush
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: core_auth
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: gen9_exec_parse
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_chamelium_hpd
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: gem_softpin
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_suspend
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: gem_mmap_offset
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_color_pipeline
results: parsing output: 64/ for test: syncobj_basic
results: parsing output: 65/ for test: kms_getfb
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_joiner
results: parsing output: 70/ for test: kms_draw_crc
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: gem_fenced_exec_thrash
results: parsing output: 73/ for test: gem_exec_fence
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: gem_wait
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_pm_rpm
results: parsing output: 81/ for test: gem_basic
results: parsing output: 82/ for test: dmabuf_sync_file
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: gem_exec_params
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: gem_exec_reloc
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_eventfd
results: parsing output: 93/ for test: kms_rotation_crc
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: gem_ctx_engines
results: parsing output: 98/ for test: gem_lmem_swapping
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_pipe_control_store_loop
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_chamelium_frames
results: parsing output: 108/ for test: kms_async_flips
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_rotation_crc
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_plane_multiple
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: prime_busy
results: parsing output: 124/ for test: kms_sequence
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: sysfs_heartbeat_interval
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_plane
results: parsing output: 132/ for test: gem_exec_parallel
Done.