[58.601747] Initializing watchdogs
[58.601790]   /dev/watchdog0
[58.615448] [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]
[58.619531] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.621701] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.624865] [001/132] (960s left) syncobj_eventfd (binary-wait)
[58.709913] Starting subtest: binary-wait
[58.720631] Subtest binary-wait: SUCCESS (0.010s)
[58.825055] [002/132] (960s left) kms_color (deep-color)
[58.925792] Starting subtest: deep-color
[59.997347] Starting dynamic subtest: pipe-A-eDP-1-gamma
[60.715670] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.720s)
[60.725238] Starting dynamic subtest: pipe-A-eDP-1-degamma
[62.180498] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.468s)
[62.188622] Starting dynamic subtest: pipe-A-eDP-1-ctm
[63.611306] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.432s)
[64.375444] Starting dynamic subtest: pipe-B-eDP-1-gamma
[65.075951] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.707s)
[65.084235] Starting dynamic subtest: pipe-B-eDP-1-degamma
[66.474227] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.401s)
[66.482392] Starting dynamic subtest: pipe-B-eDP-1-ctm
[67.925755] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.454s)
[68.679216] Starting dynamic subtest: pipe-C-eDP-1-gamma
[69.369413] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.699s)
[69.377756] Starting dynamic subtest: pipe-C-eDP-1-degamma
[70.722231] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.354s)
[70.730911] Starting dynamic subtest: pipe-C-eDP-1-ctm
[72.164783] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.441s)
[72.966222] Starting dynamic subtest: pipe-D-eDP-1-gamma
[73.681201] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.719s)
[73.688445] Starting dynamic subtest: pipe-D-eDP-1-degamma
[75.118758] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.436s)
[75.131831] Starting dynamic subtest: pipe-D-eDP-1-ctm
[76.535725] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.418s)
[76.538262] Subtest deep-color: SUCCESS (17.636s)
[77.406613] [003/132] (941s left) tools_test (tools_test)
[77.459047] Starting subtest: tools_test
[77.509767] Subtest tools_test: SUCCESS (0.065s)
[77.568673] [004/132] (941s left) gem_userptr_blits (forbidden-operations)
[77.625978] Starting subtest: forbidden-operations
[77.630071] Subtest forbidden-operations: SKIP (0.000s)
[77.734126] [005/132] (941s left) gem_exec_schedule (lateslice)
[77.800576] Starting subtest: lateslice
[77.802895] Starting dynamic subtest: rcs0
[77.811941] Dynamic subtest rcs0: SUCCESS (0.020s)
[77.818846] Starting dynamic subtest: bcs0
[77.829059] Dynamic subtest bcs0: SUCCESS (0.017s)
[77.835999] Starting dynamic subtest: vcs0
[77.847295] Dynamic subtest vcs0: SUCCESS (0.017s)
[77.854639] Starting dynamic subtest: vcs1
[77.865162] Dynamic subtest vcs1: SUCCESS (0.018s)
[77.871937] Starting dynamic subtest: vecs0
[77.883433] Dynamic subtest vecs0: SUCCESS (0.018s)
[77.890240] Starting dynamic subtest: ccs0
[77.902656] Dynamic subtest ccs0: SUCCESS (0.019s)
[77.904919] Subtest lateslice: SUCCESS (0.111s)
[79.000907] [006/132] (940s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[79.101731] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[79.106279] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[79.187680] [007/132] (940s left) gem_ccs (block-multicopy-inplace)
[79.250976] Starting subtest: block-multicopy-inplace
[79.255983] Subtest block-multicopy-inplace: SKIP (0.000s)
[79.342388] [008/132] (940s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[79.431736] Starting subtest: flip-vs-dpms-on-nop-interruptible
[79.434225] Starting dynamic subtest: A-eDP1
[81.312724] Dynamic subtest A-eDP1: SUCCESS (1.881s)
[81.322131] Starting dynamic subtest: B-eDP1
[83.122921] Dynamic subtest B-eDP1: SUCCESS (1.810s)
[83.132753] Starting dynamic subtest: C-eDP1
[84.950637] Dynamic subtest C-eDP1: SUCCESS (1.826s)
[84.960022] Starting dynamic subtest: D-eDP1
[86.777188] Dynamic subtest D-eDP1: SUCCESS (1.826s)
[86.779647] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.350s)
[87.953322] [009/132] (931s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[88.072351] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[88.077069] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[88.214380] [010/132] (931s left) gem_ctx_persistence (legacy-engines-mixed-process)
[88.279077] Starting subtest: legacy-engines-mixed-process
[88.281275] Starting dynamic subtest: render
[89.946684] Dynamic subtest render: SUCCESS (1.667s)
[89.954523] Starting dynamic subtest: bsd1
[91.928491] Dynamic subtest bsd1: SUCCESS (1.981s)
[91.936404] Starting dynamic subtest: bsd2
[93.929975] Dynamic subtest bsd2: SUCCESS (1.999s)
[93.938986] Starting dynamic subtest: blt
[95.895053] Dynamic subtest blt: SUCCESS (1.964s)
[95.905223] Starting dynamic subtest: vebox
[97.877704] Dynamic subtest vebox: SUCCESS (1.982s)
[97.880177] Subtest legacy-engines-mixed-process: SUCCESS (9.599s)
[97.952637] [011/132] (921s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[98.062159] Starting subtest: yf-tiled-16bpp-rotate-90
[98.066580] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[98.160621] [012/132] (921s left) gem_userptr_blits (invalid-null-pointer)
[98.218245] Starting subtest: invalid-null-pointer
[98.220255] Subtest invalid-null-pointer: SUCCESS (0.001s)
[98.352606] [013/132] (921s left) gem_exec_capture (capture-invisible)
[98.409073] Starting subtest: capture-invisible
[98.411532] Starting dynamic subtest: smem0
[98.416069] Dynamic subtest smem0: SKIP (0.000s)
[98.420563] Subtest capture-invisible: SKIP (0.000s)
[98.512097] [014/132] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[98.613953] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[98.618245] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[98.701913] [015/132] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[98.805171] Starting subtest: addfb25-yf-tiled-legacy
[98.807330] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[98.880092] [016/132] (920s left) gem_pxp (reject-modify-context-protection-off-1)
[99.008048] Starting subtest: reject-modify-context-protection-off-1
[99.010106] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[99.132455] [017/132] (920s left) kms_cursor_crc (cursor-offscreen-256x85)
[99.398741] Starting subtest: cursor-offscreen-256x85
[99.445479] Subtest cursor-offscreen-256x85: SKIP (0.042s)
[99.618581] [018/132] (920s left) gem_fence_thrash (bo-write-verify-threaded-none)
[99.660089] Starting subtest: bo-write-verify-threaded-none
[99.673835] Subtest bo-write-verify-threaded-none: SKIP (0.012s)
[99.724673] [019/132] (920s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[99.806072] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[99.808056] Starting dynamic subtest: pipe-A-eDP-1
[99.827035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.835845] Starting dynamic subtest: pipe-B-eDP-1
[99.857494] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.864709] Starting dynamic subtest: pipe-C-eDP-1
[99.885948] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.892940] Starting dynamic subtest: pipe-D-eDP-1
[99.911575] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.915181] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[102.130927] [020/132] (917s left) gem_exec_reloc (basic-concurrent16)
[102.193205] Subtest basic-concurrent16: SKIP (0.000s)
[102.282445] [021/132] (917s left) kms_addfb_basic (no-handle)
[102.332367] Starting subtest: no-handle
[102.334275] Subtest no-handle: SUCCESS (0.000s)
[102.487092] [022/132] (917s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[102.541873] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[102.624933] [023/132] (917s left) dumb_buffer (invalid-bpp)
[102.688069] Starting subtest: invalid-bpp
[102.690267] Subtest invalid-bpp: SUCCESS (0.000s)
[102.796594] [024/132] (917s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[102.925798] Starting subtest: flip-vs-cursor-crc-atomic
[103.612221] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.685s)
[104.444616] [025/132] (915s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[104.547169] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[104.551499] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[104.632778] [026/132] (915s left) gem_exec_reloc (basic-gtt)
[104.696043] Subtest basic-gtt: SKIP (0.000s)
[104.771874] [027/132] (915s left) gem_ctx_shared (detached-shared-gtt)
[104.841652] Starting subtest: detached-shared-gtt
[106.994527] Subtest detached-shared-gtt: SUCCESS (2.152s)
[107.392890] [028/132] (912s left) gem_eio (in-flight-external)
[107.672669] Starting subtest: in-flight-external
[108.961766] Subtest in-flight-external: SUCCESS (1.287s)
[109.102604] [029/132] (911s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[109.202566] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[109.207092] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[109.308582] [030/132] (910s left) kms_plane_scaling (planes-downscale-factor-0-75)
[109.400757] Starting subtest: planes-downscale-factor-0-75
[109.403074] Starting dynamic subtest: pipe-A
[109.421051] Dynamic subtest pipe-A: SKIP (0.018s)
[109.429411] Starting dynamic subtest: pipe-B
[109.454081] Dynamic subtest pipe-B: SKIP (0.031s)
[109.461828] Starting dynamic subtest: pipe-C
[109.484314] Dynamic subtest pipe-C: SKIP (0.031s)
[109.491922] Starting dynamic subtest: pipe-D
[109.516764] Dynamic subtest pipe-D: SKIP (0.030s)
[109.521167] Subtest planes-downscale-factor-0-75: SKIP (0.112s)
[109.612885] [031/132] (910s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[109.710582] Starting subtest: x-tiled-8bpp-rotate-90
[109.732453] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[109.829087] [032/132] (910s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[109.928915] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[109.930824] Starting dynamic subtest: pipe-A-eDP-1
[110.017142] Dynamic subtest pipe-A-eDP-1: SKIP (0.091s)
[110.024814] Starting dynamic subtest: pipe-B-eDP-1
[111.117070] Dynamic subtest pipe-B-eDP-1: SKIP (1.096s)
[111.121950] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.190s)
[112.306978] [033/132] (908s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[112.410391] Starting subtest: 4-tiled-32bpp-rotate-180
[113.821417] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.411s)
[113.937660] [034/132] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[114.025942] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[120.755982] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.732s)
[120.891846] [035/132] (899s left) kms_vblank (query-busy-hang)
[120.987817] Starting subtest: query-busy-hang
[120.989994] Starting dynamic subtest: pipe-A-eDP-1
[122.867351] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[122.881286] Starting dynamic subtest: pipe-D-eDP-1
[125.389082] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.519s)
[125.391380] Subtest query-busy-hang: SUCCESS (4.402s)
[126.187617] [036/132] (894s left) kms_flip (flip-vs-rmfb)
[126.283089] Starting subtest: flip-vs-rmfb
[126.285028] Starting dynamic subtest: A-eDP1
[134.992975] Dynamic subtest A-eDP1: SUCCESS (8.712s)
[135.002075] Starting dynamic subtest: B-eDP1
[143.617514] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[143.629042] Starting dynamic subtest: C-eDP1
[152.261791] Dynamic subtest C-eDP1: SUCCESS (8.644s)
[152.270602] Starting dynamic subtest: D-eDP1
[160.896521] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[160.900678] Subtest flip-vs-rmfb: SUCCESS (34.624s)
[162.043977] [037/132] (858s left) kms_psr (pr-cursor-plane-onoff)
[162.132648] Starting subtest: pr-cursor-plane-onoff
[162.136912] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[162.203441] [038/132] (858s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[162.585258] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[163.366249] [039/132] (857s left) perf (buffer-fill)
[163.499823] Starting subtest: buffer-fill
[163.502110] Starting dynamic subtest: 0-rcs0
[165.738042] Dynamic subtest 0-rcs0: SUCCESS (2.238s)
[165.746086] Starting dynamic subtest: 1-vcs1
[170.169439] Dynamic subtest 1-vcs1: SUCCESS (4.430s)
[170.171901] Subtest buffer-fill: SUCCESS (6.671s)
[170.217070] [040/132] (850s left) gem_exec_whisper (basic-fds-priority)
[170.280876] Starting subtest: basic-fds-priority
[194.528347] Subtest basic-fds-priority: SUCCESS (24.221s)
[194.685919] [041/132] (825s left) perf_pmu (render-node-busy-idle)
[194.743887] Starting subtest: render-node-busy-idle
[194.746635] Starting dynamic subtest: rcs0
[195.420219] Dynamic subtest rcs0: SUCCESS (0.675s)
[195.431758] Starting dynamic subtest: bcs0
[196.084963] Dynamic subtest bcs0: SUCCESS (0.663s)
[196.097653] Starting dynamic subtest: vcs0
[197.910627] Dynamic subtest vcs0: SUCCESS (1.821s)
[197.921950] Starting dynamic subtest: vcs1
[199.894548] Dynamic subtest vcs1: SUCCESS (1.979s)
[199.905105] Starting dynamic subtest: vecs0
[201.878365] Dynamic subtest vecs0: SUCCESS (1.981s)
[201.889743] Starting dynamic subtest: ccs0
[202.544498] Dynamic subtest ccs0: SUCCESS (0.664s)
[202.547448] Subtest render-node-busy-idle: SUCCESS (7.802s)
[202.617847] [042/132] (818s left) kms_vrr (flip-basic)
[202.714773] Starting subtest: flip-basic
[202.720870] Subtest flip-basic: SKIP (0.000s)
[202.783212] [043/132] (817s left) gem_fenced_exec_thrash (2-spare-fences)
[202.841391] Subtest 2-spare-fences: SKIP (0.000s)
[202.921470] [044/132] (817s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[203.018746] Starting subtest: psr-rgb101010-draw-mmap-wc
[210.054120] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.038s)
[210.188519] [045/132] (810s left) kms_plane (pixel-format-4-tiled-modifier)
[210.286829] Starting subtest: pixel-format-4-tiled-modifier
[210.315810] Starting dynamic subtest: pipe-A-plane-0
[210.981889] Dynamic subtest pipe-A-plane-0: SUCCESS (0.666s)
[210.992119] Starting dynamic subtest: pipe-A-plane-3
[211.403726] Dynamic subtest pipe-A-plane-3: SUCCESS (0.419s)
[211.413837] Starting dynamic subtest: pipe-A-plane-5
[211.417365] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[212.482288] Starting dynamic subtest: pipe-B-plane-0
[213.131160] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s)
[213.139458] Starting dynamic subtest: pipe-B-plane-3
[213.597513] Dynamic subtest pipe-B-plane-3: SUCCESS (0.466s)
[213.605669] Starting dynamic subtest: pipe-B-plane-5
[213.609230] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[213.913292] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.625s)
[214.758683] [046/132] (806s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[214.845771] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[214.848113] Starting dynamic subtest: pipe-A-eDP-1
[214.873570] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[214.884172] Starting dynamic subtest: pipe-B-eDP-1
[214.907840] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[214.916489] Starting dynamic subtest: pipe-C-eDP-1
[214.940049] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[214.948160] Starting dynamic subtest: pipe-D-eDP-1
[214.971720] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[214.976050] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[217.035410] [047/132] (803s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[217.129279] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[217.133586] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.214797] [048/132] (803s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[217.325490] Starting subtest: cursor-vs-flip-toggle
[248.223784] Subtest cursor-vs-flip-toggle: SUCCESS (30.900s)
[249.080780] [049/132] (771s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[249.184840] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[249.187146] Starting dynamic subtest: pipe-A-eDP-1
[249.209831] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[249.219991] Starting dynamic subtest: pipe-B-eDP-1
[249.241900] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[249.249763] Starting dynamic subtest: pipe-C-eDP-1
[249.271165] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[249.279359] Starting dynamic subtest: pipe-D-eDP-1
[249.300981] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[249.305285] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[251.344854] [050/132] (769s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[251.397487] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[251.403081] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[251.490826] [051/132] (769s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[251.597080] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[251.601445] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[251.703827] [052/132] (769s left) gem_pxp (create-protected-buffer)
[251.752596] Starting subtest: create-protected-buffer
[251.755074] Subtest create-protected-buffer: SUCCESS (0.000s)
[251.857797] [053/132] (769s left) kms_pm_rpm (dpms-non-lpsp)
[254.087210] Starting subtest: dpms-non-lpsp
[254.092912] Subtest dpms-non-lpsp: SKIP (0.001s)
[254.477136] [054/132] (766s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[254.587461] Starting subtest: fbc-rgb565-draw-blt
[258.699548] Subtest fbc-rgb565-draw-blt: SUCCESS (4.115s)
[259.867966] [055/132] (761s left) gem_softpin (allocator-nopin)
[259.923576] Starting subtest: allocator-nopin
[260.021625] Subtest allocator-nopin: SUCCESS (0.097s)
[260.138073] [056/132] (761s left) kms_dp_link_training (uhbr-sst)
[260.232718] Starting subtest: uhbr-sst
[260.241107] Subtest uhbr-sst: SKIP (0.000s)
[260.301460] [057/132] (760s left) kms_atomic_transition (modeset-transition-fencing)
[260.392082] Starting subtest: modeset-transition-fencing
[260.394301] Starting dynamic subtest: 1x-outputs
[271.228849] Dynamic subtest 1x-outputs: SUCCESS (10.839s)
[271.231630] Subtest modeset-transition-fencing: SUCCESS (10.841s)
[272.088673] [058/132] (749s left) syncobj_wait (invalid-reset-bad-pad)
[272.152467] Starting subtest: invalid-reset-bad-pad
[272.154772] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[272.255638] [059/132] (749s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[272.368314] Starting subtest: basic-flip-after-cursor-legacy
[273.293174] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.925s)
[274.112606] [060/132] (747s left) i915_suspend (debugfs-reader)
[274.160650] Starting subtest: debugfs-reader
[291.961762] Subtest debugfs-reader: SUCCESS (4.014s)
[292.058870] [061/132] (729s left) gem_lmem_swapping (verify-ccs)
[292.111765] Subtest verify-ccs: SKIP (0.000s)
[292.154008] [062/132] (729s left) gem_exec_fence (basic-busy-all)
[292.210645] Starting subtest: basic-busy-all
[292.295250] Subtest basic-busy-all: SUCCESS (0.087s)
[293.784913] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true
[293.788530] [063/132] (727s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[293.883693] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[294.642873] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s)
[294.803825] [064/132] (726s left) gem_mmap_gtt (zero-extend)
[294.856779] Subtest zero-extend: SKIP (0.000s)
[294.919868] [065/132] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[295.042596] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[302.422075] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.438s)
[302.560748] [066/132] (719s left) syncobj_timeline (host-signal-points)
[302.620745] Starting subtest: host-signal-points
[302.625507] Subtest host-signal-points: SUCCESS (0.004s)
[302.741800] [067/132] (718s left) perf_pmu (busy-accuracy-2)
[302.783387] Starting subtest: busy-accuracy-2
[302.785725] Starting dynamic subtest: rcs0
[305.825022] Dynamic subtest rcs0: SUCCESS (3.050s)
[305.836526] Starting dynamic subtest: bcs0
[308.932279] Dynamic subtest bcs0: SUCCESS (3.060s)
[308.942047] Starting dynamic subtest: vcs0
[311.972848] Dynamic subtest vcs0: SUCCESS (3.048s)
[311.981934] Starting dynamic subtest: vcs1
[315.023404] Dynamic subtest vcs1: SUCCESS (3.051s)
[315.034342] Starting dynamic subtest: vecs0
[318.068120] Dynamic subtest vecs0: SUCCESS (3.047s)
[318.078178] Starting dynamic subtest: ccs0
[321.081696] Dynamic subtest ccs0: SUCCESS (3.062s)
[321.084110] Subtest busy-accuracy-2: SUCCESS (18.334s)
[321.198183] [068/132] (700s left) gem_userptr_blits (nohangcheck)
[321.287785] Starting subtest: nohangcheck
[321.617471] Subtest nohangcheck: SUCCESS (0.326s)
[321.733916] [069/132] (700s left) gem_workarounds (reset-fd)
[321.818239] Starting subtest: reset-fd
[321.987278] Subtest reset-fd: SUCCESS (0.172s)
[322.122974] [070/132] (699s left) i915_drm_fdinfo (all-busy-idle-check-all)
[322.161395] Starting subtest: all-busy-idle-check-all
[322.165759] Subtest all-busy-idle-check-all: SKIP (0.003s)
[322.230676] [071/132] (699s left) gem_exec_balancer (bonded-true-hang)
[322.496225] Starting subtest: bonded-true-hang
[322.501142] Subtest bonded-true-hang: SKIP (0.000s)
[322.600878] [072/132] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[322.695852] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[322.699734] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[322.788911] [073/132] (699s left) kms_psr (fbc-pr-primary-mmap-gtt)
[322.879613] Starting subtest: fbc-pr-primary-mmap-gtt
[322.883769] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[322.952137] [074/132] (699s left) drm_read (short-buffer-block)
[323.093000] Starting subtest: short-buffer-block
[323.095343] Subtest short-buffer-block: SUCCESS (0.000s)
[323.207163] [075/132] (698s left) gem_exercise_blt (fast-copy-emit)
[323.268397] Starting subtest: fast-copy-emit
[323.270374] Starting dynamic subtest: linear-smem-smem-emit
[323.286956] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[323.298112] Starting dynamic subtest: xmajor-smem-smem-emit
[323.302960] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[323.315380] Starting dynamic subtest: tile4-smem-smem-emit
[323.320559] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.016s)
[323.329297] Starting dynamic subtest: tile64-smem-smem-emit
[323.335656] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s)
[323.337876] Subtest fast-copy-emit: SUCCESS (0.071s)
[323.442713] [076/132] (698s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[323.492504] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[323.494814] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[323.582499] [077/132] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[323.671950] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[323.675396] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[323.781671] [078/132] (698s left) gem_exec_params (invalid-bsd1-flag-on-render)
[323.835628] Starting subtest: invalid-bsd1-flag-on-render
[323.837514] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[323.930919] [079/132] (698s left) kms_atomic_interruptible (universal-setplane-primary)
[324.012659] Starting subtest: universal-setplane-primary
[324.014518] Starting dynamic subtest: pipe-A-eDP-1
[331.441268] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.427s)
[331.443667] Subtest universal-setplane-primary: SUCCESS (7.429s)
[332.280789] [080/132] (689s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[332.366092] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[339.615742] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.253s)
[339.732407] [081/132] (682s left) gem_exec_parallel (contexts)
[339.813866] Starting subtest: contexts
[339.816065] Starting dynamic subtest: rcs0
[343.260686] Dynamic subtest rcs0: SUCCESS (3.447s)
[343.269753] Starting dynamic subtest: bcs0
[347.259249] Dynamic subtest bcs0: SUCCESS (3.996s)
[347.270082] Starting dynamic subtest: vcs0
[351.331599] Dynamic subtest vcs0: SUCCESS (4.072s)
[351.343386] Starting dynamic subtest: vcs1
[355.276426] Dynamic subtest vcs1: SUCCESS (3.943s)
[355.287919] Starting dynamic subtest: vecs0
[361.084217] Dynamic subtest vecs0: SUCCESS (5.755s)
[361.096659] Starting dynamic subtest: ccs0
[365.436383] Dynamic subtest ccs0: SUCCESS (4.402s)
[365.439089] Subtest contexts: SUCCESS (25.632s)
[365.662458] [082/132] (656s left) kms_psr (psr-primary-mmap-gtt)
[365.782775] Starting subtest: psr-primary-mmap-gtt
[365.785092] Starting dynamic subtest: eDP-1
[367.209690] Dynamic subtest eDP-1: SKIP (1.424s)
[367.214340] Subtest psr-primary-mmap-gtt: SKIP (1.426s)
[367.357501] [083/132] (655s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[367.462202] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[372.089965] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.633s)
[373.258508] [084/132] (649s left) kms_cursor_crc (cursor-tearing-position-change)
[373.377408] Starting subtest: cursor-tearing-position-change
[373.379578] Starting dynamic subtest: pipe-A-eDP-1
[373.969698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.592s)
[373.981755] Starting dynamic subtest: pipe-D-eDP-1
[375.161942] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.188s)
[375.163876] Subtest cursor-tearing-position-change: SUCCESS (1.784s)
[375.991816] [085/132] (646s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[376.088656] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[376.090866] Starting dynamic subtest: pipe-A
[376.108307] Dynamic subtest pipe-A: SKIP (0.016s)
[376.118409] Starting dynamic subtest: pipe-B
[376.138116] Dynamic subtest pipe-B: SKIP (0.029s)
[376.147535] Starting dynamic subtest: pipe-C
[376.167647] Dynamic subtest pipe-C: SKIP (0.028s)
[376.177096] Starting dynamic subtest: pipe-D
[376.197225] Dynamic subtest pipe-D: SKIP (0.028s)
[376.201673] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.104s)
[376.304181] [086/132] (646s left) perf (polling-parameterized)
[376.411245] Starting subtest: polling-parameterized
[396.487116] Subtest polling-parameterized: SUCCESS (20.022s)
[396.532188] [087/132] (626s left) kms_flip (2x-busy-flip)
[396.629862] Starting subtest: 2x-busy-flip
[396.641318] Subtest 2x-busy-flip: SKIP (0.011s)
[396.721093] [088/132] (625s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[396.832595] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[396.837175] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[396.960587] [089/132] (625s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[397.003712] Starting subtest: yf-tiled-ccs-to-y-tiled
[397.008168] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[397.215012] [090/132] (625s left) gem_exec_reloc (basic-range)
[397.274860] Subtest basic-range: SKIP (0.000s)
[397.343378] [091/132] (625s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[397.457909] Starting subtest: cursorB-vs-flipA-legacy
[397.462100] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[397.602370] [092/132] (625s left) kms_properties (get_properties-sanity-non-atomic)
[397.696361] Starting subtest: get_properties-sanity-non-atomic
[397.698561] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[397.769131] [093/132] (625s left) kms_content_protection (atomic-hdcp14)
[397.915414] Starting subtest: atomic-hdcp14
[397.919813] Subtest atomic-hdcp14: SKIP (0.000s)
[398.029331] [094/132] (624s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[398.123734] Starting subtest: stress-xrgb8888-yftiled
[398.127273] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[398.200565] [095/132] (624s left) kms_flip (plain-flip-fb-recreate-interruptible)
[398.288294] Starting subtest: plain-flip-fb-recreate-interruptible
[398.290134] Starting dynamic subtest: A-eDP1
[407.175152] Dynamic subtest A-eDP1: SUCCESS (8.885s)
[407.185419] Starting dynamic subtest: B-eDP1
[416.002949] Dynamic subtest B-eDP1: SUCCESS (8.825s)
[416.015275] Starting dynamic subtest: C-eDP1
[424.826242] Dynamic subtest C-eDP1: SUCCESS (8.822s)
[424.839488] Starting dynamic subtest: D-eDP1
[433.667422] Dynamic subtest D-eDP1: SUCCESS (8.839s)
[433.672159] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.383s)
[434.831109] [096/132] (588s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[434.935757] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[434.940007] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[435.030668] [097/132] (587s left) kms_prop_blob (blob-prop-lifetime)
[435.094794] Starting subtest: blob-prop-lifetime
[435.097137] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[435.216449] [098/132] (587s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[435.315863] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[439.455766] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.143s)
[440.640529] [099/132] (582s left) gen9_exec_parse (batch-zero-length)
[440.691070] Subtest batch-zero-length: SKIP (0.000s)
[440.758840] [100/132] (582s left) api_intel_allocator (reopen)
[440.807409] Starting subtest: reopen
[440.809227] Subtest reopen: SUCCESS (0.004s)
[440.929291] [101/132] (582s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[441.026900] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[447.593993] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.572s)
[447.729596] [102/132] (575s left) gem_exec_params (invalid-bsd2-flag-on-render)
[447.796085] Starting subtest: invalid-bsd2-flag-on-render
[447.798444] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[447.904712] [103/132] (575s left) api_intel_bb (object-reloc-purge-cache)
[447.958384] Starting subtest: object-reloc-purge-cache
[447.962760] Subtest object-reloc-purge-cache: SKIP (0.003s)
[448.076517] [104/132] (575s left) gem_eio (suspend)
[448.308642] Starting subtest: suspend
[460.495799] Subtest suspend: SUCCESS (12.189s)
[460.609985] [105/132] (562s left) kms_psr2_su (frontbuffer-xrgb8888)
[460.678217] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[460.733748] [106/132] (562s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[460.801117] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[460.857576] [107/132] (562s left) kms_lease (implicit-plane-lease)
[460.953862] Starting subtest: implicit-plane-lease
[460.956114] Subtest implicit-plane-lease: SUCCESS (0.003s)
[461.060690] [108/132] (562s left) gem_ctx_persistence (engines-hang)
[461.120430] Starting subtest: engines-hang
[461.122924] Starting dynamic subtest: rcs0
[461.246386] Dynamic subtest rcs0: SUCCESS (0.126s)
[461.257423] Starting dynamic subtest: bcs0
[461.337866] Dynamic subtest bcs0: SUCCESS (0.090s)
[461.349329] Starting dynamic subtest: vcs0
[461.443635] Dynamic subtest vcs0: SUCCESS (0.104s)
[461.453246] Starting dynamic subtest: vcs1
[461.539027] Dynamic subtest vcs1: SUCCESS (0.094s)
[461.553202] Starting dynamic subtest: vecs0
[461.637812] Dynamic subtest vecs0: SUCCESS (0.096s)
[461.649772] Starting dynamic subtest: ccs0
[461.717849] Dynamic subtest ccs0: SUCCESS (0.078s)
[461.719990] Subtest engines-hang: SUCCESS (0.599s)
[461.846576] [109/132] (561s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[461.935866] Starting subtest: plane-all-modeset-transition-fencing
[461.939319] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[462.018443] [110/132] (561s left) syncobj_wait (wait-for-submit-delayed-submit)
[462.076126] Starting subtest: wait-for-submit-delayed-submit
[462.180533] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[462.261525] [111/132] (561s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[462.355444] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[462.357680] Starting dynamic subtest: pipe-A-eDP-1
[463.699020] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.342s)
[463.983351] Starting dynamic subtest: pipe-B-eDP-1
[465.025467] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[465.294210] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.941s)
[466.139677] [112/132] (557s left) i915_pm_rc6_residency (media-rc6-accuracy)
[466.196379] Starting subtest: media-rc6-accuracy
[466.201109] Subtest media-rc6-accuracy: SKIP (0.000s)
[466.324751] [113/132] (557s left) gem_ctx_engines (execute-one)
[466.386314] Starting subtest: execute-one
[469.062057] Subtest execute-one: SUCCESS (2.676s)
[469.257020] [114/132] (554s left) kms_chamelium_edid (dp-mode-timings)
[469.676403] Subtest dp-mode-timings: SKIP (0.000s)
[470.460095] [115/132] (553s left) kms_cursor_crc (cursor-random-32x32)
[470.603944] Starting subtest: cursor-random-32x32
[470.649701] Subtest cursor-random-32x32: SKIP (0.041s)
[470.969799] [116/132] (552s left) kms_plane_multiple (tiling-x)
[471.065831] Starting subtest: tiling-x
[471.067794] Starting dynamic subtest: pipe-A-eDP-1
[474.716379] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.653s)
[474.727317] Starting dynamic subtest: pipe-B-eDP-1
[479.124262] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.405s)
[479.134275] Starting dynamic subtest: pipe-C-eDP-1
[483.458922] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.336s)
[483.468989] Starting dynamic subtest: pipe-D-eDP-1
[487.788123] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.328s)
[487.790240] Subtest tiling-x: SUCCESS (16.726s)
[488.586905] [117/132] (535s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[488.691865] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[488.694167] Starting dynamic subtest: pipe-A-eDP-1
[489.604684] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.906s)
[489.613537] Starting dynamic subtest: pipe-B-eDP-1
[491.193387] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.585s)
[491.203057] Starting dynamic subtest: pipe-C-eDP-1
[492.787280] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.592s)
[492.797101] Starting dynamic subtest: pipe-D-eDP-1
[494.280179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.494s)
[494.282340] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.583s)
[495.438086] [118/132] (528s left) kms_psr (fbc-psr-cursor-render)
[495.537690] Starting subtest: fbc-psr-cursor-render
[495.539981] Starting dynamic subtest: eDP-1
[495.544377] Dynamic subtest eDP-1: SKIP (0.000s)
[495.548851] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[495.613886] [119/132] (528s left) kms_chamelium_color (ctm-blue-to-red)
[495.714052] Subtest ctm-blue-to-red: SKIP (0.000s)
[495.760171] [120/132] (528s left) gem_exec_schedule (submit-early-slice)
[495.830952] Starting subtest: submit-early-slice
[495.832981] Starting dynamic subtest: rcs0
[495.863247] Dynamic subtest rcs0: SUCCESS (0.041s)
[495.872527] Starting dynamic subtest: bcs0
[495.904266] Dynamic subtest bcs0: SUCCESS (0.040s)
[495.914638] Starting dynamic subtest: vcs0
[495.944371] Dynamic subtest vcs0: SUCCESS (0.039s)
[495.954593] Starting dynamic subtest: vcs1
[495.991028] Dynamic subtest vcs1: SUCCESS (0.046s)
[496.002137] Starting dynamic subtest: vecs0
[496.033248] Dynamic subtest vecs0: SUCCESS (0.042s)
[496.044407] Starting dynamic subtest: ccs0
[496.077049] Dynamic subtest ccs0: SUCCESS (0.043s)
[496.079358] Subtest submit-early-slice: SUCCESS (0.255s)
[497.801959] [121/132] (526s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[497.897453] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[497.899796] Starting dynamic subtest: pipe-A-default-mode
[499.084378] Dynamic subtest pipe-A-default-mode: SKIP (1.185s)
[499.088824] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.186s)
[499.232176] [122/132] (524s left) sysfs_defaults (readonly)
[499.302735] Starting subtest: readonly
[499.305132] Starting dynamic subtest: vecs0
[499.307434] Dynamic subtest vecs0: SUCCESS (0.000s)
[499.318713] Starting dynamic subtest: ccs0
[499.320877] Dynamic subtest ccs0: SUCCESS (0.000s)
[499.329600] Starting dynamic subtest: vcs0
[499.331815] Dynamic subtest vcs0: SUCCESS (0.000s)
[499.340857] Starting dynamic subtest: bcs0
[499.343018] Dynamic subtest bcs0: SUCCESS (0.000s)
[499.352122] Starting dynamic subtest: rcs0
[499.354332] Dynamic subtest rcs0: SUCCESS (0.000s)
[499.363229] Starting dynamic subtest: vcs1
[499.365112] Dynamic subtest vcs1: SUCCESS (0.000s)
[499.366998] Subtest readonly: SUCCESS (0.006s)
[499.440112] [123/132] (524s left) gem_exec_fence (syncobj-timeline-chain-engines)
[500.007188] Starting subtest: syncobj-timeline-chain-engines
[500.138289] Subtest syncobj-timeline-chain-engines: SUCCESS (0.131s)
[501.789457] [124/132] (522s left) syncobj_wait (invalid-signal-one-illegal-handle)
[501.847129] Starting subtest: invalid-signal-one-illegal-handle
[501.849469] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[501.943352] [125/132] (522s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[502.039595] Starting subtest: fbc-rgb101010-draw-mmap-wc
[506.637895] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.600s)
[507.754146] [126/132] (516s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[507.840619] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[514.912714] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.076s)
[515.060743] [127/132] (509s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[515.191854] Starting subtest: cursorB-vs-flipB-atomic
[515.196158] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[515.349546] [128/132] (508s left) kms_psr (psr2-sprite-blt)
[515.442685] Starting subtest: psr2-sprite-blt
[515.444890] Starting dynamic subtest: eDP-1
[517.116535] Dynamic subtest eDP-1: SUCCESS (1.673s)
[517.118501] Subtest psr2-sprite-blt: SUCCESS (1.674s)
[517.970647] [129/132] (506s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[518.074924] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[518.079226] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[518.169583] [130/132] (506s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[518.265083] Starting subtest: invalid-modeset-force-ultra-joiner
[518.269629] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[518.329779] [131/132] (506s left) i915_hangman (detector)
[518.391057] Starting subtest: detector
[518.392996] Starting dynamic subtest: rcs0
[529.690333] Dynamic subtest rcs0: SUCCESS (11.302s)
[529.705388] Starting dynamic subtest: bcs0
[541.659289] Dynamic subtest bcs0: SUCCESS (11.968s)
[541.673716] Starting dynamic subtest: vcs0
[553.626016] Dynamic subtest vcs0: SUCCESS (11.966s)
[553.638694] Starting dynamic subtest: vcs1
[564.635096] Dynamic subtest vcs1: SUCCESS (11.009s)
[564.646778] Starting dynamic subtest: vecs0
[576.602892] Dynamic subtest vecs0: SUCCESS (11.968s)
[576.615123] Starting dynamic subtest: ccs0
[587.676167] Dynamic subtest ccs0: SUCCESS (11.073s)
[587.678879] Subtest detector: SUCCESS (69.303s)
[587.761585] [132/132] (436s left) syncobj_timeline (single-wait-available-submitted)
[587.827806] Starting subtest: single-wait-available-submitted
[587.830091] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[587.932023] Closing watchdogs
results: parsing output: 0/ for test: syncobj_eventfd
results: parsing output: 1/ for test: kms_color
results: parsing output: 2/ for test: tools_test
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_ccs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: gem_exec_capture
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: gem_fence_thrash
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: dumb_buffer
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: gem_ctx_shared
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_chamelium_hpd
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: perf_pmu
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: gem_fenced_exec_thrash
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: kms_dp_link_training
results: parsing output: 56/ for test: kms_atomic_transition
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: i915_suspend
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: gem_workarounds
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: drm_read
results: parsing output: 74/ for test: gem_exercise_blt
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: kms_atomic_interruptible
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_parallel
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: kms_pipe_stress
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_prop_blob
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: api_intel_allocator
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_psr2_su
results: parsing output: 105/ for test: kms_pipe_b_c_ivb
results: parsing output: 106/ for test: kms_lease
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: kms_atomic_transition
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_atomic_transition
results: parsing output: 111/ for test: i915_pm_rc6_residency
results: parsing output: 112/ for test: gem_ctx_engines
results: parsing output: 113/ for test: kms_chamelium_edid
results: parsing output: 114/ for test: kms_cursor_crc
results: parsing output: 115/ for test: kms_plane_multiple
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_chamelium_color
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: sysfs_defaults
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_joiner
results: parsing output: 130/ for test: i915_hangman
results: parsing output: 131/ for test: syncobj_timeline
Done.