[58.654702] Initializing watchdogs
[58.654829]   /dev/watchdog0
[58.670325] [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.674774] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.677123] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.680404] [001/132] (960s left) gem_userptr_blits (unsync-unmap)
[58.779953] Subtest unsync-unmap: SKIP (0.000s)
[58.905775] [002/132] (960s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[59.007140] Starting subtest: fbc-psr-sprite-mmap-cpu
[59.009500] Starting dynamic subtest: eDP-1
[59.013638] Dynamic subtest eDP-1: SKIP (0.000s)
[59.017777] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[59.090750] [003/132] (960s left) gem_ctx_persistence (engines-queued)
[59.146581] Starting subtest: engines-queued
[59.148805] Starting dynamic subtest: rcs0
[59.221492] Dynamic subtest rcs0: SUCCESS (0.074s)
[59.230958] Starting dynamic subtest: bcs0
[59.291189] Dynamic subtest bcs0: SUCCESS (0.068s)
[59.300795] Starting dynamic subtest: vcs0
[60.855657] Dynamic subtest vcs0: SUCCESS (1.548s)
[60.865632] Starting dynamic subtest: vcs1
[62.836947] Dynamic subtest vcs1: SUCCESS (1.967s)
[62.847757] Starting dynamic subtest: vecs0
[64.885507] Dynamic subtest vecs0: SUCCESS (2.036s)
[64.896213] Starting dynamic subtest: ccs0
[65.056559] Dynamic subtest ccs0: SUCCESS (0.171s)
[65.059142] Subtest engines-queued: SUCCESS (5.872s)
[65.185847] [004/132] (954s left) kms_async_flips (invalid-async-flip-atomic)
[65.289814] Starting subtest: invalid-async-flip-atomic
[65.665751] Starting dynamic subtest: pipe-A-eDP-1
[66.538281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.869s)
[66.908752] Starting dynamic subtest: pipe-B-eDP-1
[67.688644] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[68.044629] Starting dynamic subtest: pipe-C-eDP-1
[68.904162] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.866s)
[69.261983] Starting dynamic subtest: pipe-D-eDP-1
[70.028896] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[70.031297] Subtest invalid-async-flip-atomic: SUCCESS (4.726s)
[71.205844] [005/132] (948s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[71.310998] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[71.313200] Starting dynamic subtest: pipe-A-default-mode
[72.455787] Dynamic subtest pipe-A-default-mode: SKIP (1.139s)
[72.460497] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.140s)
[72.608201] [006/132] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[72.731356] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[72.735631] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[72.816225] [007/132] (946s left) gem_exec_balancer (bonded-false-hang)
[73.083731] Starting subtest: bonded-false-hang
[73.088948] Subtest bonded-false-hang: SKIP (0.000s)
[73.185601] [008/132] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[73.287761] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[80.069069] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.777s)
[80.200425] [009/132] (939s left) gem_eio (in-flight-contexts-1us)
[80.384620] Starting subtest: in-flight-contexts-1us
[91.950952] Subtest in-flight-contexts-1us: SUCCESS (11.556s)
[92.096947] [010/132] (927s left) gem_exec_schedule (u-fairslice)
[92.178431] Starting subtest: u-fairslice
[92.180864] Starting dynamic subtest: rcs0
[94.196832] Dynamic subtest rcs0: SUCCESS (2.026s)
[94.206078] Starting dynamic subtest: bcs0
[96.218989] Dynamic subtest bcs0: SUCCESS (2.022s)
[96.228932] Starting dynamic subtest: vcs0
[98.248492] Dynamic subtest vcs0: SUCCESS (2.027s)
[98.259181] Starting dynamic subtest: vcs1
[100.270342] Dynamic subtest vcs1: SUCCESS (2.020s)
[100.278099] Starting dynamic subtest: vecs0
[102.291942] Dynamic subtest vecs0: SUCCESS (2.021s)
[102.300923] Starting dynamic subtest: ccs0
[104.320155] Dynamic subtest ccs0: SUCCESS (2.026s)
[104.322048] Subtest u-fairslice: SUCCESS (12.145s)
[104.638772] [011/132] (914s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[105.239654] Starting subtest: syncobj-timeline-multiple-ext-nodes
[105.243704] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[106.976395] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[106.979224] [012/132] (912s left) kms_sequence (get-forked-busy)
[107.068871] Starting subtest: get-forked-busy
[107.071212] Starting dynamic subtest: pipe-A-eDP-1
[109.060524] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.990s)
[109.070626] Starting dynamic subtest: pipe-B-eDP-1
[111.675599] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.613s)
[111.687752] Starting dynamic subtest: pipe-C-eDP-1
[114.273838] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.596s)
[114.288983] Starting dynamic subtest: pipe-D-eDP-1
[116.903068] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.628s)
[116.905093] Subtest get-forked-busy: SUCCESS (9.831s)
[117.711798] [013/132] (901s left) gem_exec_whisper (basic-contexts-priority)
[117.795901] Starting subtest: basic-contexts-priority
[141.542066] Subtest basic-contexts-priority: SUCCESS (23.739s)
[141.739139] [014/132] (877s left) kms_psr (pr-cursor-plane-onoff)
[141.834632] Starting subtest: pr-cursor-plane-onoff
[141.838933] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[141.911338] [015/132] (877s left) kms_async_flips (alternate-sync-async-flip-atomic)
[141.998252] Starting subtest: alternate-sync-async-flip-atomic
[142.384599] Starting dynamic subtest: pipe-A-eDP-1
[145.189579] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.806s)
[145.594221] Starting dynamic subtest: pipe-B-eDP-1
[148.327515] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.741s)
[148.730801] Starting dynamic subtest: pipe-C-eDP-1
[151.463135] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.741s)
[151.831258] Starting dynamic subtest: pipe-D-eDP-1
[154.593757] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[154.595903] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.600s)
[155.759689] [016/132] (864s left) gem_ctx_persistence (legacy-engines-mixed)
[155.828532] Starting subtest: legacy-engines-mixed
[155.830806] Starting dynamic subtest: render
[155.904065] Dynamic subtest render: SUCCESS (0.075s)
[155.915882] Starting dynamic subtest: bsd1
[155.935562] Dynamic subtest bsd1: SUCCESS (0.029s)
[155.943774] Starting dynamic subtest: bsd2
[156.002593] Dynamic subtest bsd2: SUCCESS (0.065s)
[156.013835] Starting dynamic subtest: blt
[156.048020] Dynamic subtest blt: SUCCESS (0.045s)
[156.058942] Starting dynamic subtest: vebox
[156.094782] Dynamic subtest vebox: SUCCESS (0.045s)
[156.097287] Subtest legacy-engines-mixed: SUCCESS (0.267s)
[156.172646] [017/132] (863s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[156.264882] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[156.267169] Starting dynamic subtest: pipe-A-eDP-1
[188.402159] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.052s)
[188.412466] Starting dynamic subtest: pipe-B-eDP-1
[221.316938] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.609s)
[221.328250] Starting dynamic subtest: pipe-C-eDP-1
[254.312269] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.619s)
[254.323170] Starting dynamic subtest: pipe-D-eDP-1
[287.324661] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.666s)
[287.326900] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.951s)
[288.592588] [018/132] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[288.699419] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[288.703818] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[288.798603] [019/132] (731s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[288.901088] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[289.937271] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.015s)
[290.069616] [020/132] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[290.170160] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[290.173588] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[290.279710] [021/132] (729s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[290.376031] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[294.743790] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.301s)
[295.927882] [022/132] (724s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[296.043389] Starting subtest: psr-rgb101010-draw-render
[303.378434] Subtest psr-rgb101010-draw-render: SUCCESS (7.290s)
[303.501023] [023/132] (716s left) gem_exec_reloc (basic-write-gtt-noreloc)
[303.559121] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[303.624186] [024/132] (716s left) vgem_basic (unload)
[303.667868] Starting subtest: unload
[332.812024] Subtest unload: SUCCESS (29.022s)
[332.914078] [025/132] (687s left) i915_query (query-regions-sanity-check)
[332.961881] Starting subtest: query-regions-sanity-check
[332.968305] Subtest query-regions-sanity-check: SUCCESS (0.009s)
[333.062335] [026/132] (687s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[333.173756] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[333.988283] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.814s)
[334.155819] [027/132] (686s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[334.212958] Starting subtest: yf-tiled-ccs-to-yf-tiled
[334.217871] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[334.400945] [028/132] (685s left) kms_psr (psr-basic)
[334.498695] Starting subtest: psr-basic
[334.501022] Starting dynamic subtest: eDP-1
[336.105743] Dynamic subtest eDP-1: SUCCESS (1.604s)
[336.108139] Subtest psr-basic: SUCCESS (1.605s)
[336.984580] [029/132] (683s left) kms_addfb_basic (addfb25-bad-modifier)
[337.075761] Starting subtest: addfb25-bad-modifier
[337.077636] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[337.171310] [030/132] (683s left) gem_render_tiled_blits (basic)
[337.229595] Subtest basic: SKIP (0.000s)
[337.309592] [031/132] (683s left) kms_psr (psr-sprite-plane-onoff)
[337.402411] Starting subtest: psr-sprite-plane-onoff
[337.404687] Starting dynamic subtest: eDP-1
[339.222717] Dynamic subtest eDP-1: SUCCESS (1.817s)
[339.224915] Subtest psr-sprite-plane-onoff: SUCCESS (1.818s)
[340.041745] [032/132] (680s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[340.131028] Starting subtest: psr-1p-pri-indfb-multidraw
[362.503802] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.369s)
[362.613699] [033/132] (657s left) kms_draw_crc (draw-method-mmap-gtt)
[362.710637] Starting subtest: draw-method-mmap-gtt
[362.714193] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[362.810367] [034/132] (657s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[362.915169] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[362.917124] Starting dynamic subtest: pipe-A-eDP-1
[362.934090] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[362.943987] Starting dynamic subtest: pipe-B-eDP-1
[362.960552] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[362.969101] Starting dynamic subtest: pipe-C-eDP-1
[362.985072] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[362.993568] Starting dynamic subtest: pipe-D-eDP-1
[363.010567] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[363.012346] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[365.163479] [035/132] (655s left) syncobj_timeline (wait-all-delayed-signal)
[365.215373] Starting subtest: wait-all-delayed-signal
[365.318791] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[365.394686] [036/132] (655s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[365.492587] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[365.496745] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[365.565844] [037/132] (655s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[365.646554] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[365.648850] Starting dynamic subtest: pipe-A-eDP-1
[365.707478] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[365.718681] Starting dynamic subtest: pipe-B-eDP-1
[365.778345] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[365.789307] Starting dynamic subtest: pipe-C-eDP-1
[365.846417] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[365.857279] Starting dynamic subtest: pipe-D-eDP-1
[365.913601] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[365.918060] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[367.915839] [038/132] (652s left) kms_getfb (getfb2-handle-protection)
[368.008898] Starting subtest: getfb2-handle-protection
[368.021689] Subtest getfb2-handle-protection: SUCCESS (0.014s)
[368.160635] [039/132] (652s left) kms_cursor_crc (cursor-random-64x64)
[368.330332] Starting subtest: cursor-random-64x64
[368.335487] Starting dynamic subtest: pipe-A-eDP-1
[371.683140] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.347s)
[371.710612] Starting dynamic subtest: pipe-D-eDP-1
[375.826915] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.122s)
[375.829113] Subtest cursor-random-64x64: SUCCESS (7.493s)
[376.667360] [040/132] (644s left) api_intel_allocator (reserve-simple)
[376.720011] Starting subtest: reserve-simple
[376.722358] Subtest reserve-simple: SUCCESS (0.003s)
[376.825919] [041/132] (643s left) gem_exec_reloc (basic-wc)
[376.899352] Subtest basic-wc: SKIP (0.000s)
[376.997982] [042/132] (643s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[377.082566] Starting subtest: primary-y-tiled-reflect-x-0
[377.142802] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[377.246255] [043/132] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[377.353289] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[377.357418] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[377.448659] [044/132] (643s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[377.556960] Starting subtest: blocking-absolute-wf_vblank-interruptible
[377.559308] Starting dynamic subtest: A-eDP1
[386.221582] Dynamic subtest A-eDP1: SUCCESS (8.661s)
[386.232974] Starting dynamic subtest: B-eDP1
[394.955094] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[394.966282] Starting dynamic subtest: C-eDP1
[403.677387] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[403.687026] Starting dynamic subtest: D-eDP1
[412.411299] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[412.417257] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.847s)
[413.620450] [045/132] (607s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[413.714922] Starting subtest: fbc-shrfb-scaledprimary
[416.689458] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.978s)
[417.834630] [046/132] (603s left) syncobj_timeline (reset-during-wait-for-submit)
[417.893666] Starting subtest: reset-during-wait-for-submit
[417.997044] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[418.079186] [047/132] (602s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[418.190124] Starting subtest: short-flip-before-cursor-toggle
[419.100064] Subtest short-flip-before-cursor-toggle: SUCCESS (0.910s)
[419.943095] [048/132] (601s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[420.044030] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[420.048457] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[420.133717] [049/132] (601s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[420.230985] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[420.233252] Starting dynamic subtest: pipe-A-eDP-1
[422.418477] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.189s)
[422.428350] Starting dynamic subtest: pipe-B-eDP-1
[424.493174] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.075s)
[424.502926] Starting dynamic subtest: pipe-C-eDP-1
[426.519620] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.025s)
[426.530189] Starting dynamic subtest: pipe-D-eDP-1
[428.515692] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.997s)
[428.517805] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.290s)
[429.694323] [050/132] (591s left) vgem_basic (dmabuf-mmap)
[429.761231] Starting subtest: dmabuf-mmap
[429.786279] Subtest dmabuf-mmap: SUCCESS (0.030s)
[429.844860] [051/132] (591s left) kms_big_fb (linear-16bpp-rotate-270)
[429.930420] Starting subtest: linear-16bpp-rotate-270
[429.950264] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[430.081361] [052/132] (591s left) kms_plane_lowres (tiling-yf)
[430.194952] Starting subtest: tiling-yf
[430.199471] Subtest tiling-yf: SKIP (0.000s)
[430.268941] [053/132] (591s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[430.321553] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[430.382898] [054/132] (590s left) kms_content_protection (lic-type-1)
[430.527464] Starting subtest: lic-type-1
[430.531893] Subtest lic-type-1: SKIP (0.000s)
[430.650763] [055/132] (590s left) kms_flip (2x-absolute-wf_vblank)
[430.745377] Starting subtest: 2x-absolute-wf_vblank
[430.756138] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[430.845999] [056/132] (590s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[430.934621] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[430.938012] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[431.017623] [057/132] (590s left) dumb_buffer (map-valid)
[431.073984] Starting subtest: map-valid
[431.075860] Subtest map-valid: SUCCESS (0.000s)
[431.169787] [058/132] (590s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[431.257236] Starting subtest: plane-upscale-20x20-with-modifiers
[431.259229] Starting dynamic subtest: pipe-A
[431.593035] Dynamic subtest pipe-A: SUCCESS (0.338s)
[431.602399] Starting dynamic subtest: pipe-B
[433.005637] Dynamic subtest pipe-B: SUCCESS (1.412s)
[433.020107] Starting dynamic subtest: pipe-C
[434.418550] Dynamic subtest pipe-C: SUCCESS (1.412s)
[434.428208] Starting dynamic subtest: pipe-D
[435.847568] Dynamic subtest pipe-D: SUCCESS (1.427s)
[435.849926] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.594s)
[437.023041] [059/132] (584s left) kms_cursor_crc (cursor-onscreen-64x64)
[437.206173] Starting subtest: cursor-onscreen-64x64
[437.212263] Starting dynamic subtest: pipe-A-eDP-1
[439.307115] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.098s)
[439.336744] Starting dynamic subtest: pipe-D-eDP-1
[442.099619] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[442.101991] Subtest cursor-onscreen-64x64: SUCCESS (4.892s)
[442.983857] [060/132] (578s left) gem_request_retire (retire-vma-not-inactive)
[443.051938] Starting subtest: retire-vma-not-inactive
[443.111655] Subtest retire-vma-not-inactive: SUCCESS (0.060s)
[443.273239] [061/132] (578s left) kms_psr2_su (page_flip-p010)
[443.350557] Subtest page_flip-P010: SKIP (0.000s)
[443.417553] [062/132] (578s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[443.521449] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[444.479507] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.957s)
[444.601721] [063/132] (577s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[444.696813] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[444.699117] Starting dynamic subtest: A-eDP1
[448.279151] Dynamic subtest A-eDP1: SUCCESS (3.580s)
[448.290012] Starting dynamic subtest: B-eDP1
[451.484261] Dynamic subtest B-eDP1: SUCCESS (3.203s)
[451.496858] Starting dynamic subtest: C-eDP1
[454.585293] Dynamic subtest C-eDP1: SUCCESS (3.101s)
[454.596423] Starting dynamic subtest: D-eDP1
[457.701598] Dynamic subtest D-eDP1: SUCCESS (3.112s)
[457.703754] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.004s)
[458.504321] [064/132] (563s left) syncobj_wait (single-wait-all-for-submit-signaled)
[458.570047] Starting subtest: single-wait-all-for-submit-signaled
[458.571981] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[458.661503] [065/132] (563s left) kms_atomic_interruptible (legacy-dpms)
[458.753796] Starting subtest: legacy-dpms
[458.756107] Starting dynamic subtest: pipe-A-eDP-1
[466.145798] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.390s)
[466.147983] Subtest legacy-dpms: SUCCESS (7.391s)
[466.965012] [066/132] (554s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[467.088076] Starting subtest: basic-busy-flip-before-cursor-legacy
[467.092421] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[467.231651] [067/132] (554s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[467.333030] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[467.359235] Starting dynamic subtest: pipe-A-plane-0
[467.658545] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[467.670905] Starting dynamic subtest: pipe-A-plane-3
[467.892143] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[467.902244] Starting dynamic subtest: pipe-A-plane-5
[467.906033] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[468.961882] Starting dynamic subtest: pipe-B-plane-0
[469.253177] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[469.263536] Starting dynamic subtest: pipe-B-plane-3
[469.498357] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[469.513033] Starting dynamic subtest: pipe-B-plane-5
[469.517390] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[469.812084] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.480s)
[470.647401] [068/132] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[470.748154] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[470.752499] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[470.827626] [069/132] (551s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[470.932712] Starting subtest: y-tiled-16bpp-rotate-0
[470.936724] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[471.036023] [070/132] (551s left) gem_exec_reloc (basic-wc-cpu)
[471.090924] Subtest basic-wc-cpu: SKIP (0.000s)
[471.169219] [071/132] (550s left) prime_busy (before-wait)
[471.222307] Starting subtest: before-wait
[471.226870] Starting dynamic subtest: rcs0
[471.257533] Dynamic subtest rcs0: SUCCESS (0.031s)
[471.268199] Starting dynamic subtest: bcs0
[471.297649] Dynamic subtest bcs0: SUCCESS (0.039s)
[471.307168] Starting dynamic subtest: vcs0
[471.337980] Dynamic subtest vcs0: SUCCESS (0.040s)
[471.347358] Starting dynamic subtest: vcs1
[471.378133] Dynamic subtest vcs1: SUCCESS (0.039s)
[471.387481] Starting dynamic subtest: vecs0
[471.419401] Dynamic subtest vecs0: SUCCESS (0.041s)
[471.428612] Starting dynamic subtest: ccs0
[471.460878] Dynamic subtest ccs0: SUCCESS (0.041s)
[471.570062] Subtest before-wait: SUCCESS (0.346s)
[471.644667] [072/132] (550s left) kms_cursor_crc (cursor-sliding-64x21)
[471.862243] Starting subtest: cursor-sliding-64x21
[471.915912] Subtest cursor-sliding-64x21: SKIP (0.046s)
[472.160210] [073/132] (550s left) syncobj_wait (single-wait-all-submitted)
[472.217580] Starting subtest: single-wait-all-submitted
[472.321843] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[472.397233] [074/132] (549s left) perf_pmu (busy-accuracy-50)
[472.442162] Starting subtest: busy-accuracy-50
[472.444468] Starting dynamic subtest: rcs0
[473.977088] Dynamic subtest rcs0: SUCCESS (1.531s)
[473.986579] Starting dynamic subtest: bcs0
[475.520334] Dynamic subtest bcs0: SUCCESS (1.541s)
[475.529915] Starting dynamic subtest: vcs0
[477.078964] Dynamic subtest vcs0: SUCCESS (1.533s)
[477.089619] Starting dynamic subtest: vcs1
[478.594228] Dynamic subtest vcs1: SUCCESS (1.536s)
[478.605293] Starting dynamic subtest: vecs0
[480.139988] Dynamic subtest vecs0: SUCCESS (1.543s)
[480.151088] Starting dynamic subtest: ccs0
[481.685484] Dynamic subtest ccs0: SUCCESS (1.543s)
[481.688022] Subtest busy-accuracy-50: SUCCESS (9.240s)
[481.798083] [075/132] (540s left) i915_pm_freq_api (freq-reset-multiple)
[481.860217] Starting subtest: freq-reset-multiple
[481.862514] Starting dynamic subtest: gt0
[490.648998] Dynamic subtest gt0: SUCCESS (8.784s)
[490.659153] Starting dynamic subtest: gt1
[498.274587] Dynamic subtest gt1: SUCCESS (7.623s)
[498.277718] Subtest freq-reset-multiple: SUCCESS (16.409s)
[498.352169] [076/132] (523s left) api_intel_bb (simple-bb)
[498.415803] Starting subtest: simple-bb
[498.422064] Subtest simple-bb: SUCCESS (0.010s)
[498.554360] [077/132] (523s left) kms_pm_dc (dc9-dpms)
[499.645458] Starting subtest: dc9-dpms
[501.069534] Subtest dc9-dpms: SUCCESS (1.423s)
[501.130637] [078/132] (521s left) gem_exec_reloc (basic-wc-read-active)
[501.181363] Subtest basic-wc-read-active: SKIP (0.000s)
[501.258249] [079/132] (521s left) perf_pmu (idle-no-semaphores)
[501.299918] Starting subtest: idle-no-semaphores
[501.301896] Starting dynamic subtest: rcs0
[501.857185] Dynamic subtest rcs0: SUCCESS (0.556s)
[501.870023] Starting dynamic subtest: bcs0
[502.381553] Dynamic subtest bcs0: SUCCESS (0.521s)
[502.392758] Starting dynamic subtest: vcs0
[502.897696] Dynamic subtest vcs0: SUCCESS (0.513s)
[502.908295] Starting dynamic subtest: vcs1
[503.414560] Dynamic subtest vcs1: SUCCESS (0.513s)
[503.431304] Starting dynamic subtest: vecs0
[503.933745] Dynamic subtest vecs0: SUCCESS (0.516s)
[503.949237] Starting dynamic subtest: ccs0
[504.456325] Dynamic subtest ccs0: SUCCESS (0.519s)
[504.461148] Subtest idle-no-semaphores: SUCCESS (3.157s)
[504.559564] [080/132] (517s left) template (a)
[504.620055] Starting subtest: A
[504.622376] Subtest A: SUCCESS (0.000s)
[504.721767] [081/132] (517s left) gem_wait (busy)
[504.787094] Starting subtest: busy
[504.789411] Starting dynamic subtest: all-engines
[506.587998] Dynamic subtest all-engines: SUCCESS (1.799s)
[506.599974] Starting dynamic subtest: rcs0
[507.131597] Dynamic subtest rcs0: SUCCESS (0.542s)
[507.153657] Starting dynamic subtest: bcs0
[507.672858] Dynamic subtest bcs0: SUCCESS (0.540s)
[507.685104] Starting dynamic subtest: vcs0
[509.596868] Dynamic subtest vcs0: SUCCESS (1.921s)
[509.609075] Starting dynamic subtest: vcs1
[511.580331] Dynamic subtest vcs1: SUCCESS (1.981s)
[511.592502] Starting dynamic subtest: vecs0
[513.565190] Dynamic subtest vecs0: SUCCESS (1.982s)
[513.577598] Starting dynamic subtest: ccs0
[514.106571] Dynamic subtest ccs0: SUCCESS (0.540s)
[514.109051] Subtest busy: SUCCESS (9.317s)
[514.320770] [082/132] (508s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[514.431742] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[514.434031] Starting dynamic subtest: pipe-A-eDP-1
[514.571835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.131s)
[514.584146] Starting dynamic subtest: pipe-B-eDP-1
[514.603663] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[514.612886] Starting dynamic subtest: pipe-C-eDP-1
[514.631964] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[514.641256] Starting dynamic subtest: pipe-D-eDP-1
[514.660699] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[514.662585] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.141s)
[516.874003] [083/132] (505s left) gem_mmap_wc (invalid-flags)
[516.934597] Subtest invalid-flags: SKIP (0.000s)
[516.996697] [084/132] (505s left) gem_mmap_wc (pf-nonblock)
[517.049144] Subtest pf-nonblock: SKIP (0.000s)
[517.108409] [085/132] (505s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[517.219588] Starting subtest: flip-vs-cursor-legacy
[524.323106] Subtest flip-vs-cursor-legacy: SUCCESS (7.102s)
[525.116403] [086/132] (497s left) gem_cs_tlb (engines)
[525.185560] Starting subtest: engines
[525.187708] Starting dynamic subtest: rcs0
[527.338154] Dynamic subtest rcs0: SUCCESS (2.151s)
[527.347978] Starting dynamic subtest: bcs0
[529.492997] Dynamic subtest bcs0: SUCCESS (2.152s)
[529.505731] Starting dynamic subtest: vcs0
[531.647203] Dynamic subtest vcs0: SUCCESS (2.153s)
[531.657509] Starting dynamic subtest: vcs1
[533.799932] Dynamic subtest vcs1: SUCCESS (2.151s)
[533.812844] Starting dynamic subtest: vecs0
[535.952949] Dynamic subtest vecs0: SUCCESS (2.152s)
[535.965128] Starting dynamic subtest: ccs0
[538.109482] Dynamic subtest ccs0: SUCCESS (2.154s)
[538.112105] Subtest engines: SUCCESS (12.920s)
[538.233632] [087/132] (484s left) i915_drm_fdinfo (memory-info-active)
[538.273640] Starting subtest: memory-info-active
[538.276007] Starting dynamic subtest: smem0
[541.403995] Dynamic subtest smem0: SUCCESS (3.132s)
[541.406073] Subtest memory-info-active: SUCCESS (3.133s)
[541.477171] [088/132] (481s left) gem_lmem_swapping (massive)
[541.520298] Subtest massive: SKIP (0.000s)
[541.565596] [089/132] (481s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[541.661868] Starting subtest: fbc-pr-sprite-mmap-gtt
[541.665430] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[541.734139] [090/132] (481s left) kms_color (ctm-red-to-blue)
[541.826823] Starting subtest: ctm-red-to-blue
[541.828632] Starting dynamic subtest: pipe-A-eDP-1
[542.541469] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[542.550951] Starting dynamic subtest: pipe-B-eDP-1
[543.936732] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s)
[543.946494] Starting dynamic subtest: pipe-C-eDP-1
[545.311172] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[545.322169] Starting dynamic subtest: pipe-D-eDP-1
[546.641979] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[546.644351] Subtest ctm-red-to-blue: SUCCESS (4.816s)
[547.442097] [091/132] (475s left) kms_flip (flip-vs-modeset-vs-hang)
[547.537077] Starting subtest: flip-vs-modeset-vs-hang
[547.539593] Starting dynamic subtest: A-eDP1
[599.029506] Dynamic subtest A-eDP1: SUCCESS (51.495s)
[599.043087] Starting dynamic subtest: D-eDP1
[650.036880] Dynamic subtest D-eDP1: SUCCESS (51.000s)
[650.039383] Subtest flip-vs-modeset-vs-hang: SUCCESS (102.499s)
[650.412481] [092/132] (372s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[650.502841] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[650.506965] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[650.593012] [093/132] (372s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[650.642737] Starting subtest: single-wait-for-submit-unsubmitted
[650.745988] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[650.835333] [094/132] (372s left) kms_cursor_legacy (single-move)
[650.949534] Starting subtest: single-move
[650.951817] Starting dynamic subtest: pipe-A
[656.333096] Dynamic subtest pipe-A: SUCCESS (5.380s)
[656.343326] Starting dynamic subtest: pipe-B
[661.718133] Dynamic subtest pipe-B: SUCCESS (5.381s)
[661.727805] Starting dynamic subtest: pipe-C
[667.100620] Dynamic subtest pipe-C: SUCCESS (5.379s)
[667.110221] Starting dynamic subtest: pipe-D
[672.485560] Dynamic subtest pipe-D: SUCCESS (5.381s)
[672.496275] Starting dynamic subtest: all-pipes
[677.875832] Dynamic subtest all-pipes: SUCCESS (5.386s)
[677.878237] Subtest single-move: SUCCESS (26.921s)
[678.020355] [095/132] (345s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[678.110604] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[678.112932] Starting dynamic subtest: pipe-A-default-mode
[679.274820] Dynamic subtest pipe-A-default-mode: SKIP (1.162s)
[679.279533] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.163s)
[679.417637] [096/132] (343s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[679.535849] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[679.538138] Starting dynamic subtest: pipe-A
[679.556142] Dynamic subtest pipe-A: SKIP (0.017s)
[679.567677] Starting dynamic subtest: pipe-B
[679.586119] Dynamic subtest pipe-B: SKIP (0.029s)
[679.606133] Starting dynamic subtest: pipe-C
[679.621604] Dynamic subtest pipe-C: SKIP (0.031s)
[679.641825] Starting dynamic subtest: pipe-D
[679.650838] Dynamic subtest pipe-D: SKIP (0.031s)
[679.654654] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.112s)
[679.760427] [097/132] (343s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[679.870852] Starting subtest: yf-tiled-addfb-size-overflow
[679.875258] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[679.954497] [098/132] (343s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[680.010101] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[680.113816] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[680.194562] [099/132] (343s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[680.583105] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[681.360054] [100/132] (341s left) kms_flip (bo-too-big)
[681.460321] Starting subtest: bo-too-big
[681.462290] Starting dynamic subtest: A-eDP1
[682.722768] Dynamic subtest A-eDP1: SUCCESS (1.264s)
[682.734055] Starting dynamic subtest: B-eDP1
[684.051897] Dynamic subtest B-eDP1: SUCCESS (1.328s)
[684.063806] Starting dynamic subtest: C-eDP1
[685.403154] Dynamic subtest C-eDP1: SUCCESS (1.350s)
[685.418740] Starting dynamic subtest: D-eDP1
[686.729120] Dynamic subtest D-eDP1: SUCCESS (1.323s)
[686.731565] Subtest bo-too-big: SUCCESS (5.274s)
[687.958748] [101/132] (335s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[688.020208] Starting subtest: y-tiled-to-vebox-yf-tiled
[688.024854] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[688.220840] [102/132] (335s left) syncobj_timeline (etime-multi-wait-all-submitted)
[688.286277] Starting subtest: etime-multi-wait-all-submitted
[688.393732] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[688.487872] [103/132] (334s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[688.552424] Starting subtest: multi-wait-all-available-submitted-signaled
[688.554470] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[688.657354] [104/132] (334s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[688.771954] Starting subtest: basic-flip-after-cursor-atomic
[689.692012] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.917s)
[690.557945] [105/132] (333s left) kms_rotation_crc (primary-rotation-180)
[690.659661] Starting subtest: primary-rotation-180
[697.799206] Subtest primary-rotation-180: SUCCESS (7.140s)
[699.018166] [106/132] (324s left) gen9_exec_parse (allowed-all)
[699.077642] Subtest allowed-all: SKIP (0.000s)
[699.136749] [107/132] (324s left) core_setmaster (master-drop-set-root)
[699.197161] Starting subtest: master-drop-set-root
[699.222466] Subtest master-drop-set-root: SUCCESS (0.025s)
[699.271117] [108/132] (324s left) i915_pm_rc6_residency (rc6-idle)
[699.322844] Starting subtest: rc6-idle
[699.353824] Starting dynamic subtest: gt0-rcs0
[723.726572] Dynamic subtest gt0-rcs0: SUCCESS (24.367s)
[723.736708] Starting dynamic subtest: gt0-bcs0
[748.185588] Dynamic subtest gt0-bcs0: SUCCESS (24.452s)
[748.195170] Starting dynamic subtest: gt0-ccs0
[772.548800] Dynamic subtest gt0-ccs0: SUCCESS (24.355s)
[772.561063] Starting dynamic subtest: gt1-vcs0
[778.721926] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[778.734678] Starting dynamic subtest: gt1-vecs0
[784.894969] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[784.897979] Subtest rc6-idle: SUCCESS (85.556s)
[784.976098] [109/132] (238s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[785.077591] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[785.081677] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[785.167584] [110/132] (238s left) sysfs_timeslice_duration (duration)
[785.224036] Starting subtest: duration
[785.226426] Starting dynamic subtest: vecs0
[798.458573] Dynamic subtest vecs0: SUCCESS (13.229s)
[798.471056] Starting dynamic subtest: ccs0
[811.583416] Dynamic subtest ccs0: SUCCESS (13.131s)
[811.595585] Starting dynamic subtest: vcs0
[825.467024] Dynamic subtest vcs0: SUCCESS (13.886s)
[825.479628] Starting dynamic subtest: bcs0
[838.605103] Dynamic subtest bcs0: SUCCESS (13.141s)
[838.618261] Starting dynamic subtest: rcs0
[851.743652] Dynamic subtest rcs0: SUCCESS (13.140s)
[851.757366] Starting dynamic subtest: vcs1
[866.490770] Dynamic subtest vcs1: SUCCESS (14.746s)
[866.494256] Subtest duration: SUCCESS (81.289s)
[866.567055] [111/132] (157s left) gem_exec_schedule (fifo)
[866.653400] Starting subtest: fifo
[866.655496] Starting dynamic subtest: rcs0
[866.800930] Dynamic subtest rcs0: SUCCESS (0.157s)
[866.812792] Starting dynamic subtest: vcs0
[866.906708] Dynamic subtest vcs0: SUCCESS (0.105s)
[866.920984] Starting dynamic subtest: vcs1
[867.024477] Dynamic subtest vcs1: SUCCESS (0.116s)
[867.035607] Starting dynamic subtest: vecs0
[867.135665] Dynamic subtest vecs0: SUCCESS (0.110s)
[867.148175] Starting dynamic subtest: ccs0
[867.260021] Dynamic subtest ccs0: SUCCESS (0.123s)
[867.262379] Subtest fifo: SUCCESS (0.617s)
[868.669294] [112/132] (155s left) kms_flip (2x-plain-flip)
[868.778646] Starting subtest: 2x-plain-flip
[868.789395] Subtest 2x-plain-flip: SKIP (0.010s)
[868.872991] [113/132] (155s left) kms_chamelium_color (ctm-max)
[868.974975] Subtest ctm-max: SKIP (0.000s)
[869.025064] [114/132] (154s left) gem_exec_balancer (parallel-keep-submit-fence)
[869.283514] Starting subtest: parallel-keep-submit-fence
[870.370755] Subtest parallel-keep-submit-fence: SUCCESS (1.091s)
[870.488300] [115/132] (153s left) kms_invalid_mode (zero-clock)
[870.578490] Starting subtest: zero-clock
[870.580638] Starting dynamic subtest: pipe-A-eDP-1
[870.858408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[870.869298] Starting dynamic subtest: pipe-B-eDP-1
[870.871514] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[870.881512] Starting dynamic subtest: pipe-C-eDP-1
[870.884205] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[870.894029] Starting dynamic subtest: pipe-D-eDP-1
[870.896323] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[870.898503] Subtest zero-clock: SUCCESS (0.288s)
[871.744949] [116/132] (152s left) gem_spin_batch (spin-all)
[871.804593] Starting subtest: spin-all
[871.819297] Subtest spin-all: SUCCESS (0.013s)
[873.606202] [117/132] (150s left) gem_exec_schedule (out-order)
[873.681604] Starting subtest: out-order
[873.683842] Starting dynamic subtest: rcs0
[873.778733] Dynamic subtest rcs0: SUCCESS (0.105s)
[873.791927] Starting dynamic subtest: vcs0
[873.869298] Dynamic subtest vcs0: SUCCESS (0.088s)
[873.886361] Starting dynamic subtest: vcs1
[873.959554] Dynamic subtest vcs1: SUCCESS (0.089s)
[873.972693] Starting dynamic subtest: vecs0
[874.040473] Dynamic subtest vecs0: SUCCESS (0.080s)
[874.053636] Starting dynamic subtest: ccs0
[874.128736] Dynamic subtest ccs0: SUCCESS (0.087s)
[874.131174] Subtest out-order: SUCCESS (0.456s)
[875.644613] [118/132] (148s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[875.755906] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[875.759606] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[875.864167] [119/132] (148s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[875.983711] Starting subtest: cursorB-vs-flipB-toggle
[875.988205] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[876.130284] [120/132] (148s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[876.241290] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[882.969617] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.733s)
[883.107080] [121/132] (141s left) kms_pm_rpm (pc8-residency)
[884.751254] Starting subtest: pc8-residency
[884.755990] Subtest pc8-residency: SKIP (0.000s)
[885.374600] [122/132] (138s left) kms_lease (lease-again)
[885.475506] Starting subtest: lease-again
[885.477747] Starting dynamic subtest: pipe-A-eDP-1
[885.480042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[885.492389] Starting dynamic subtest: pipe-B-eDP-1
[885.494259] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[885.503602] Starting dynamic subtest: pipe-C-eDP-1
[885.505474] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[885.514608] Starting dynamic subtest: pipe-D-eDP-1
[885.516454] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[885.518242] Subtest lease-again: SUCCESS (0.012s)
[885.604605] [123/132] (138s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[885.705681] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[892.301323] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.598s)
[892.439658] [124/132] (131s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[892.535710] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[896.194211] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.663s)
[897.343854] [125/132] (127s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[897.439231] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[897.443289] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[897.538731] [126/132] (126s left) gem_workarounds (reset-context)
[897.605210] Starting subtest: reset-context
[897.784097] Subtest reset-context: SUCCESS (0.179s)
[897.898774] [127/132] (126s left) kms_vblank (wait-busy)
[897.989127] Starting subtest: wait-busy
[897.991260] Starting dynamic subtest: pipe-A-eDP-1
[899.876591] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[899.891628] Starting dynamic subtest: pipe-D-eDP-1
[902.483792] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.603s)
[902.486036] Subtest wait-busy: SUCCESS (4.497s)
[903.290100] [128/132] (121s left) gem_workarounds (basic-read-fd)
[903.358399] Starting subtest: basic-read-fd
[903.369588] Subtest basic-read-fd: SUCCESS (0.010s)
[903.494512] [129/132] (121s left) kms_fbcon_fbt (psr)
[903.553333] Starting subtest: psr
[910.904407] Subtest psr: SUCCESS (7.350s)
[910.985504] [130/132] (113s left) kms_chamelium_frames (dp-crc-single)
[911.366573] Subtest dp-crc-single: SKIP (0.000s)
[912.134514] [131/132] (112s left) gem_mmap_offset (partial-unmap)
[912.186772] Starting subtest: partial-unmap
[912.189036] Starting dynamic subtest: smem0
[912.690575] Dynamic subtest smem0: SUCCESS (0.504s)
[912.693183] Subtest partial-unmap: SUCCESS (0.505s)
[912.801819] [132/132] (111s left) kms_pipe_stress (stress-xrgb8888-untiled)
[912.909144] Starting subtest: stress-xrgb8888-untiled
[918.823124] Subtest stress-xrgb8888-untiled: SUCCESS (5.918s)
[918.875692] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: gem_ctx_persistence
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: gem_exec_fence
results: parsing output: 11/ for test: kms_sequence
results: parsing output: 12/ for test: gem_exec_whisper
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_async_flips
results: parsing output: 15/ for test: gem_ctx_persistence
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: vgem_basic
results: parsing output: 24/ for test: i915_query
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: gem_render_tiled_blits
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_draw_crc
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_getfb
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: api_intel_allocator
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_rotation_crc
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: vgem_basic
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_plane_lowres
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: dumb_buffer
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: gem_request_retire
results: parsing output: 60/ for test: kms_psr2_su
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_atomic_interruptible
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_plane
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: kms_cursor_crc
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: i915_pm_freq_api
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_pm_dc
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: template
results: parsing output: 80/ for test: gem_wait
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_mmap_wc
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: gem_cs_tlb
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_rotation_crc
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: core_setmaster
results: parsing output: 107/ for test: i915_pm_rc6_residency
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: sysfs_timeslice_duration
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_chamelium_color
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: gem_spin_batch
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_pm_rpm
results: parsing output: 121/ for test: kms_lease
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_workarounds
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: gem_workarounds
results: parsing output: 128/ for test: kms_fbcon_fbt
results: parsing output: 129/ for test: kms_chamelium_frames
results: parsing output: 130/ for test: gem_mmap_offset
results: parsing output: 131/ for test: kms_pipe_stress
Done.