[66.720029] Initializing watchdogs
[66.720078]   /dev/watchdog0
[66.739995] [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]
[66.745590] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[66.748693] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.752311] [001/133] (960s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[66.907300] Starting subtest: psr-modesetfrombusy
[73.059617] Subtest psr-modesetfrombusy: SUCCESS (6.149s)
[73.193378] [002/133] (954s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[73.300691] Starting subtest: yf-tiled-32bpp-rotate-270
[73.304482] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[73.397940] [003/133] (953s left) kms_vrr (negative-basic)
[73.501900] Starting subtest: negative-basic
[73.507508] Starting dynamic subtest: pipe-A-eDP-1
[79.455203] Dynamic subtest pipe-A-eDP-1: FAIL (5.450s)
[79.456963] Subtest negative-basic: FAIL (5.739s)
[80.067718] [004/133] (947s left) kms_chamelium_color (ctm-0-75)
[80.157935] Subtest ctm-0-75: SKIP (0.000s)
[80.207443] [005/133] (947s left) kms_flip (flip-vs-panning-interruptible)
[80.327875] Starting subtest: flip-vs-panning-interruptible
[80.330241] Starting dynamic subtest: A-eDP1
[89.088464] Dynamic subtest A-eDP1: SUCCESS (8.759s)
[89.097683] Starting dynamic subtest: B-eDP1
[97.816314] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[97.824662] Starting dynamic subtest: C-eDP1
[106.537145] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[106.544083] Starting dynamic subtest: D-eDP1
[115.187691] Dynamic subtest D-eDP1: SUCCESS (8.649s)
[115.192315] Subtest flip-vs-panning-interruptible: SUCCESS (34.863s)
[116.351432] [006/133] (911s left) kms_cursor_edge_walk (128x128-left-edge)
[116.448886] Starting subtest: 128x128-left-edge
[116.451138] Starting dynamic subtest: pipe-A-eDP-1
[119.922858] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[119.932608] Starting dynamic subtest: pipe-D-eDP-1
[123.056574] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[123.059063] Subtest 128x128-left-edge: SUCCESS (6.609s)
[123.842321] [007/133] (903s left) kms_flip (2x-flip-vs-wf_vblank)
[123.942338] Starting subtest: 2x-flip-vs-wf_vblank
[123.950634] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[124.028315] [008/133] (903s left) gem_exec_gttfill (basic)
[124.084623] Starting subtest: basic
[126.571358] Subtest basic: SUCCESS (2.486s)
[126.759881] [009/133] (900s left) i915_pm_freq_mult (media-freq)
[126.864439] Starting subtest: media-freq
[126.866789] Starting dynamic subtest: gt0
[126.871223] Dynamic subtest gt0: SKIP (0.000s)
[126.879525] Starting dynamic subtest: gt1
[126.883878] Dynamic subtest gt1: SKIP (0.000s)
[126.888115] Subtest media-freq: SKIP (0.001s)
[126.953762] [010/133] (900s left) gem_exec_suspend (basic-s3-devices)
[127.013290] Starting subtest: basic-S3-devices
[127.015721] Starting dynamic subtest: smem
[138.841093] Dynamic subtest smem: SUCCESS (11.824s)
[138.843989] Subtest basic-S3-devices: SUCCESS (11.826s)
[139.047355] [011/133] (888s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[139.150406] Starting subtest: fbc-pr-cursor-mmap-gtt
[139.154689] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[139.220622] [012/133] (888s left) gem_exec_schedule (fairslice-all)
[139.312459] Starting subtest: fairslice-all
[141.365267] Subtest fairslice-all: SUCCESS (2.057s)
[141.657878] [013/133] (886s left) kms_psr (pr-sprite-plane-onoff)
[141.765979] Starting subtest: pr-sprite-plane-onoff
[141.770604] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[141.833529] [014/133] (885s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[141.939572] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[141.943573] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[142.038505] [015/133] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[142.137118] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[142.141112] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[142.223638] [016/133] (885s left) gem_userptr_blits (sync-overlap)
[142.298712] Starting subtest: sync-overlap
[142.301086] Subtest sync-overlap: SUCCESS (0.000s)
[142.434453] [017/133] (885s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[142.523263] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[142.525529] Starting dynamic subtest: pipe-A-eDP-1
[158.494541] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.475s)
[158.506325] Starting dynamic subtest: pipe-B-eDP-1
[175.452630] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.419s)
[175.470011] Starting dynamic subtest: pipe-C-eDP-1
[192.414638] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.326s)
[192.423951] Starting dynamic subtest: pipe-D-eDP-1
[209.450374] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.380s)
[209.453192] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.605s)
[210.666875] [018/133] (817s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[210.771599] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[210.774292] Starting dynamic subtest: pipe-A
[211.010667] Dynamic subtest pipe-A: SUCCESS (0.241s)
[211.021304] Starting dynamic subtest: pipe-B
[212.345526] Dynamic subtest pipe-B: SUCCESS (1.329s)
[212.356297] Starting dynamic subtest: pipe-C
[213.729456] Dynamic subtest pipe-C: SUCCESS (1.379s)
[213.743964] Starting dynamic subtest: pipe-D
[215.028362] Dynamic subtest pipe-D: SUCCESS (1.294s)
[215.031354] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.249s)
[216.209244] [019/133] (811s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[216.270480] Starting subtest: single-wait-all-for-submit-unsubmitted
[216.378525] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[216.469039] [020/133] (811s left) kms_chamelium_frames (hdmi-frame-dump)
[216.850376] Subtest hdmi-frame-dump: SKIP (0.000s)
[217.638226] [021/133] (810s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[217.742517] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[217.747383] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[217.835734] [022/133] (810s left) kms_psr (fbc-psr-primary-page-flip)
[217.926428] Starting subtest: fbc-psr-primary-page-flip
[217.928879] Starting dynamic subtest: eDP-1
[217.933529] Dynamic subtest eDP-1: SKIP (0.000s)
[217.938336] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[218.008884] [023/133] (810s left) gem_softpin (allocator-nopin)
[218.070066] Starting subtest: allocator-nopin
[218.157790] Subtest allocator-nopin: SUCCESS (0.088s)
[218.277097] [024/133] (809s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[218.373820] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[224.978239] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.601s)
[225.114565] [025/133] (803s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[225.210443] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[226.335516] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.124s)
[226.443986] [026/133] (801s left) kms_flip (flip-vs-rmfb-interruptible)
[226.535596] Starting subtest: flip-vs-rmfb-interruptible
[226.537568] Starting dynamic subtest: A-eDP1
[235.185281] Dynamic subtest A-eDP1: SUCCESS (8.641s)
[235.194665] Starting dynamic subtest: B-eDP1
[243.815110] Dynamic subtest B-eDP1: SUCCESS (8.626s)
[243.826246] Starting dynamic subtest: C-eDP1
[252.430365] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[252.444498] Starting dynamic subtest: D-eDP1
[261.064925] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[261.069803] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.524s)
[262.248465] [027/133] (766s left) syncobj_eventfd (binary-wait-before-signal)
[262.300415] Starting subtest: binary-wait-before-signal
[262.329471] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[262.405371] [028/133] (765s left) gem_render_copy (yf-tiled)
[262.469726] Starting subtest: yf-tiled
[262.474499] Subtest yf-tiled: SKIP (0.000s)
[262.656218] [029/133] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[262.761794] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[262.766735] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[262.860212] [030/133] (765s left) gem_ctx_exec (basic-norecovery)
[262.919207] Starting subtest: basic-norecovery
[263.254552] Subtest basic-norecovery: SUCCESS (0.335s)
[263.374905] [031/133] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[263.478872] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[270.669972] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.194s)
[270.792336] [032/133] (757s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[270.883726] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[270.886052] Starting dynamic subtest: pipe-A-eDP-1
[270.948728] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[270.959316] Starting dynamic subtest: pipe-B-eDP-1
[271.027382] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[271.037810] Starting dynamic subtest: pipe-C-eDP-1
[271.104506] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[271.114274] Starting dynamic subtest: pipe-D-eDP-1
[271.179015] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[271.183930] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[273.094397] [033/133] (755s left) kms_addfb_basic (clobberred-modifier)
[273.145272] Starting subtest: clobberred-modifier
[273.150652] Subtest clobberred-modifier: SKIP (0.000s)
[273.283999] [034/133] (755s left) kms_vblank (query-idle)
[273.380809] Starting subtest: query-idle
[273.383169] Starting dynamic subtest: pipe-A-eDP-1
[275.135547] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[275.150474] Starting dynamic subtest: pipe-D-eDP-1
[277.609845] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.474s)
[277.612409] Subtest query-idle: SUCCESS (4.232s)
[278.422635] [035/133] (750s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[278.522288] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[278.527273] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[278.592773] [036/133] (750s left) gem_tiled_pread_basic (basic)
[278.648309] Subtest basic: SKIP (0.000s)
[278.705675] [037/133] (750s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[278.805653] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[278.811220] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[278.902675] [038/133] (749s left) gem_exec_balancer (parallel-out-fence)
[279.155225] Starting subtest: parallel-out-fence
[280.540227] Subtest parallel-out-fence: SUCCESS (1.385s)
[280.632126] [039/133] (748s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[280.731635] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[280.736900] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[280.833576] [040/133] (748s left) gem_eio (hibernate)
[281.063195] Starting subtest: hibernate
[295.602509] Subtest hibernate: SUCCESS (14.538s)
[302.761788] [041/133] (733s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[302.884784] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[302.889284] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[302.999254] [042/133] (732s left) gem_softpin (invalid)
[303.066488] Starting subtest: invalid
[303.077291] Subtest invalid: SUCCESS (0.011s)
[303.193961] [043/133] (732s left) kms_content_protection (lic-type-0)
[303.339909] Starting subtest: lic-type-0
[303.345353] Subtest lic-type-0: SKIP (0.000s)
[303.454161] [044/133] (732s left) kms_psr (psr-dpms)
[303.542354] Starting subtest: psr-dpms
[303.545065] Starting dynamic subtest: eDP-1
[306.560487] Dynamic subtest eDP-1: SUCCESS (3.016s)
[306.563432] Subtest psr-dpms: SUCCESS (3.017s)
[307.431857] [045/133] (728s left) prime_vgem (basic-fence-mmap)
[307.547307] Starting subtest: basic-fence-mmap
[307.552732] Subtest basic-fence-mmap: SKIP (0.000s)
[307.644388] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[307.649312] [046/133] (728s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[307.750049] Starting subtest: fbcpsr-shrfb-scaledprimary
[313.510995] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.764s)
[313.640487] [047/133] (722s left) gem_pxp (create-regular-buffer)
[313.769501] Starting subtest: create-regular-buffer
[313.772178] Subtest create-regular-buffer: SUCCESS (0.000s)
[313.888369] [048/133] (722s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[313.978282] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[313.983384] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[314.065995] [049/133] (722s left) gem_exec_schedule (preempt-self)
[314.153316] Starting subtest: preempt-self
[314.155955] Starting dynamic subtest: rcs0
[314.171804] Dynamic subtest rcs0: SUCCESS (0.029s)
[314.181522] Starting dynamic subtest: bcs0
[314.189968] Dynamic subtest bcs0: SUCCESS (0.018s)
[314.199510] Starting dynamic subtest: vcs0
[314.208874] Dynamic subtest vcs0: SUCCESS (0.018s)
[314.222465] Starting dynamic subtest: vcs1
[314.235056] Dynamic subtest vcs1: SUCCESS (0.024s)
[314.245035] Starting dynamic subtest: vecs0
[314.252358] Dynamic subtest vecs0: SUCCESS (0.017s)
[314.262232] Starting dynamic subtest: ccs0
[314.270292] Dynamic subtest ccs0: SUCCESS (0.017s)
[314.273049] Subtest preempt-self: SUCCESS (0.129s)
[316.279657] [050/133] (720s left) gem_exec_whisper (basic-sync-all)
[316.349628] Starting subtest: basic-sync-all
[325.251909] Subtest basic-sync-all: SUCCESS (8.903s)
[325.442787] [051/133] (710s left) kms_draw_crc (draw-method-render)
[325.537482] Starting subtest: draw-method-render
[325.540379] Starting dynamic subtest: xrgb8888-untiled
[325.767229] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[325.777105] Starting dynamic subtest: rgb565-untiled
[325.978111] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[325.988421] Starting dynamic subtest: xrgb2101010-untiled
[326.189282] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[326.202712] Starting dynamic subtest: xbgr16161616f-untiled
[326.411020] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[326.424470] Starting dynamic subtest: xrgb8888-xtiled
[326.533403] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[326.543673] Starting dynamic subtest: rgb565-xtiled
[326.644734] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[326.655037] Starting dynamic subtest: xrgb2101010-xtiled
[326.756103] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[326.765966] Starting dynamic subtest: xbgr16161616f-xtiled
[326.877724] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[326.887395] Starting dynamic subtest: xrgb8888-4tiled
[327.000157] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[327.010301] Starting dynamic subtest: rgb565-4tiled
[327.122072] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[327.134991] Starting dynamic subtest: xrgb2101010-4tiled
[327.233933] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[327.244125] Starting dynamic subtest: xbgr16161616f-4tiled
[327.355999] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.120s)
[327.358075] Subtest draw-method-render: SUCCESS (1.823s)
[327.461204] [052/133] (708s left) tools_test (tools_test)
[327.518067] Starting subtest: tools_test
[327.581762] Subtest tools_test: SUCCESS (0.078s)
[327.649796] [053/133] (708s left) kms_pm_rpm (modeset-lpsp-stress)
[329.380728] Starting subtest: modeset-lpsp-stress
[345.873685] Subtest modeset-lpsp-stress: SUCCESS (16.491s)
[345.962749] [054/133] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[346.050002] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[346.054691] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[346.132316] [055/133] (690s left) i915_drm_fdinfo (busy)
[346.181048] Starting subtest: busy
[346.183335] Starting dynamic subtest: rcs0
[346.190620] Dynamic subtest rcs0: SKIP (0.010s)
[346.200276] Starting dynamic subtest: bcs0
[346.207802] Dynamic subtest bcs0: SKIP (0.016s)
[346.220142] Starting dynamic subtest: vcs0
[346.225090] Dynamic subtest vcs0: SKIP (0.000s)
[346.234701] Starting dynamic subtest: vcs1
[346.239711] Dynamic subtest vcs1: SKIP (0.000s)
[346.249397] Starting dynamic subtest: vecs0
[346.254507] Dynamic subtest vecs0: SKIP (0.000s)
[346.264055] Starting dynamic subtest: ccs0
[346.269055] Dynamic subtest ccs0: SKIP (0.000s)
[346.274011] Subtest busy: SKIP (0.031s)
[346.314842] [056/133] (690s left) kms_prop_blob (invalid-get-prop)
[346.381374] Starting subtest: invalid-get-prop
[346.383964] Subtest invalid-get-prop: SUCCESS (0.000s)
[346.474121] [057/133] (690s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[346.572615] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[353.486758] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.916s)
[353.613282] [058/133] (683s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[353.724398] Starting subtest: yf-tiled-addfb-size-overflow
[353.729510] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[353.806627] [059/133] (682s left) gem_userptr_blits (create-destroy-unsync)
[353.872263] Subtest create-destroy-unsync: SKIP (0.000s)
[354.003049] [060/133] (682s left) vgem_basic (dmabuf-export)
[354.040163] Starting subtest: dmabuf-export
[354.060427] Subtest dmabuf-export: SUCCESS (0.023s)
[354.157833] [061/133] (682s left) kms_universal_plane (universal-plane-sanity)
[354.252485] Starting subtest: universal-plane-sanity
[354.255231] Starting dynamic subtest: pipe-A-eDP-1
[354.844403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.591s)
[354.855878] Starting dynamic subtest: pipe-B-eDP-1
[356.100363] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[356.112095] Starting dynamic subtest: pipe-C-eDP-1
[357.296962] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s)
[357.308333] Starting dynamic subtest: pipe-D-eDP-1
[358.535351] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[358.538189] Subtest universal-plane-sanity: SUCCESS (4.284s)
[359.389771] [062/133] (677s left) syncobj_wait (signal)
[359.445064] Starting subtest: signal
[359.447466] Subtest signal: SUCCESS (0.000s)
[359.549221] [063/133] (677s left) gem_mmap_offset (blt-coherency)
[359.610537] Starting subtest: blt-coherency
[359.614965] Subtest blt-coherency: SUCCESS (0.009s)
[359.756109] [064/133] (677s left) gen7_exec_parse (chained-batch)
[359.826165] Subtest chained-batch: SKIP (0.000s)
[359.887689] [065/133] (677s left) kms_invalid_mode (bad-hsync-end)
[359.992222] Starting subtest: bad-hsync-end
[359.994795] Starting dynamic subtest: pipe-A-eDP-1
[360.275066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[360.285697] Starting dynamic subtest: pipe-B-eDP-1
[360.287731] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[360.299776] Starting dynamic subtest: pipe-C-eDP-1
[360.302398] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[360.312596] Starting dynamic subtest: pipe-D-eDP-1
[360.315235] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[360.317879] Subtest bad-hsync-end: SUCCESS (0.289s)
[361.111336] [066/133] (675s left) api_intel_allocator (simple-allocator)
[361.174418] Starting subtest: simple-allocator
[361.177209] Starting dynamic subtest: basic
[361.179842] Dynamic subtest basic: SUCCESS (0.004s)
[361.192028] Starting dynamic subtest: parallel-one
[361.370523] Dynamic subtest parallel-one: SUCCESS (0.193s)
[361.380704] Starting dynamic subtest: print
[361.383244] Dynamic subtest print: SUCCESS (0.000s)
[361.393356] Starting dynamic subtest: reuse
[361.395655] Dynamic subtest reuse: SUCCESS (0.000s)
[361.405391] Starting dynamic subtest: reserve
[361.407733] Dynamic subtest reserve: SUCCESS (0.000s)
[361.417362] Starting dynamic subtest: fork-reopen-allocator
[361.419773] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[361.421942] Subtest simple-allocator: SUCCESS (0.215s)
[361.502358] [067/133] (675s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[361.596671] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[361.602054] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[361.695132] [068/133] (675s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[361.796188] Starting subtest: pr-cursor-plane-move-continuous-sf
[361.801105] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[361.877667] [069/133] (675s left) gem_mmap_gtt (basic-read-write-distinct)
[361.935376] Subtest basic-read-write-distinct: SKIP (0.000s)
[361.994013] [070/133] (675s left) prime_mmap_coherency (ioctl-errors)
[362.058466] Starting subtest: ioctl-errors
[384.658271] Subtest ioctl-errors: SUCCESS (22.595s)
[384.788861] [071/133] (652s left) kms_psr (psr-cursor-mmap-gtt)
[384.909523] Starting subtest: psr-cursor-mmap-gtt
[384.911915] Starting dynamic subtest: eDP-1
[386.609472] Dynamic subtest eDP-1: SUCCESS (1.701s)
[386.612375] Subtest psr-cursor-mmap-gtt: SUCCESS (1.702s)
[387.475148] [072/133] (649s left) gem_ctx_shared (single-timeline)
[387.539318] Starting subtest: single-timeline
[387.560322] Subtest single-timeline: SUCCESS (0.016s)
[387.779606] [073/133] (649s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[387.843094] Starting subtest: multi-wait-for-submit-submitted-signaled
[387.845504] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[387.916361] [074/133] (649s left) kms_cursor_crc (cursor-offscreen-128x42)
[388.158016] Starting subtest: cursor-offscreen-128x42
[388.203197] Subtest cursor-offscreen-128x42: SKIP (0.042s)
[388.401344] [075/133] (649s left) i915_hangman (engine-engine-error)
[388.459384] Starting subtest: engine-engine-error
[388.461765] Starting dynamic subtest: rcs0
[390.204786] Dynamic subtest rcs0: SUCCESS (1.745s)
[390.216343] Starting dynamic subtest: bcs0
[392.187997] Dynamic subtest bcs0: SUCCESS (1.980s)
[392.204193] Starting dynamic subtest: vcs0
[394.107170] Dynamic subtest vcs0: SUCCESS (1.916s)
[394.124201] Starting dynamic subtest: vcs1
[395.197120] Dynamic subtest vcs1: SUCCESS (1.088s)
[395.212097] Starting dynamic subtest: vecs0
[397.180360] Dynamic subtest vecs0: SUCCESS (1.980s)
[397.196921] Starting dynamic subtest: ccs0
[399.164712] Dynamic subtest ccs0: SUCCESS (1.982s)
[399.168292] Subtest engine-engine-error: SUCCESS (10.705s)
[399.247425] [076/133] (638s left) dmabuf_sync_file (import-basic)
[399.292330] Starting subtest: import-basic
[399.295046] Subtest import-basic: SUCCESS (0.001s)
[399.347410] [077/133] (638s left) gem_exec_flush (basic-wb-set-default)
[399.408963] Starting subtest: basic-wb-set-default
[404.916310] Subtest basic-wb-set-default: SUCCESS (5.464s)
[405.074949] [078/133] (632s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[405.206488] Starting subtest: 2x-flip-vs-cursor-legacy
[405.211622] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[405.352765] [079/133] (632s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[405.401662] Starting subtest: etime-single-wait-for-submit-unsubmitted
[405.506766] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[405.588753] [080/133] (632s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[405.693316] Starting subtest: short-busy-flip-before-cursor-toggle
[405.697776] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[405.836951] [081/133] (631s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[405.929795] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[405.932163] Starting dynamic subtest: pipe-A-eDP-1
[405.954963] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[405.965787] Starting dynamic subtest: pipe-B-eDP-1
[405.990409] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[405.999948] Starting dynamic subtest: pipe-C-eDP-1
[406.024714] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[406.034132] Starting dynamic subtest: pipe-D-eDP-1
[406.060292] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[406.065365] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[408.226736] [082/133] (629s left) gem_wait (invalid-flags)
[408.284175] Starting subtest: invalid-flags
[408.286951] Subtest invalid-flags: SUCCESS (0.000s)
[408.497254] [083/133] (629s left) gem_exec_schedule (lateslice)
[408.566351] Starting subtest: lateslice
[408.569206] Starting dynamic subtest: rcs0
[408.577925] Dynamic subtest rcs0: SUCCESS (0.025s)
[408.588251] Starting dynamic subtest: bcs0
[408.596477] Dynamic subtest bcs0: SUCCESS (0.018s)
[408.607104] Starting dynamic subtest: vcs0
[408.613999] Dynamic subtest vcs0: SUCCESS (0.017s)
[408.624285] Starting dynamic subtest: vcs1
[408.633750] Dynamic subtest vcs1: SUCCESS (0.019s)
[408.643735] Starting dynamic subtest: vecs0
[408.653025] Dynamic subtest vecs0: SUCCESS (0.019s)
[408.663352] Starting dynamic subtest: ccs0
[408.672366] Dynamic subtest ccs0: SUCCESS (0.019s)
[408.675284] Subtest lateslice: SUCCESS (0.120s)
[410.285238] [084/133] (627s left) gem_basic (multigpu-create-close)
[410.341302] Starting subtest: multigpu-create-close
[410.346307] Subtest multigpu-create-close: SKIP (0.000s)
[410.433011] [085/133] (627s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[410.521903] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[410.524140] Starting dynamic subtest: pipe-A-eDP-1
[410.583883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[410.915322] Starting dynamic subtest: pipe-B-eDP-1
[411.737021] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.845s)
[412.024427] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.501s)
[412.903566] [086/133] (624s left) kms_chamelium_frames (vga-frame-dump)
[413.291477] Subtest vga-frame-dump: SKIP (0.000s)
[414.112250] [087/133] (623s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[414.219136] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[414.224352] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[414.326532] [088/133] (623s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[414.387223] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[414.443636] [089/133] (623s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[414.497240] Starting subtest: yf-tiled-to-vebox-x-tiled
[414.501886] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[414.681923] [090/133] (623s left) kms_cursor_crc (cursor-sliding-128x42)
[414.905957] Starting subtest: cursor-sliding-128x42
[414.952717] Subtest cursor-sliding-128x42: SKIP (0.041s)
[415.148321] [091/133] (622s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[415.211148] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[415.314569] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[415.404609] [092/133] (622s left) syncobj_wait (invalid-reset-bad-pad)
[415.455792] Starting subtest: invalid-reset-bad-pad
[415.458384] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[415.547049] [093/133] (622s left) syncobj_wait (single-wait-signaled)
[415.601502] Starting subtest: single-wait-signaled
[415.604152] Subtest single-wait-signaled: SUCCESS (0.000s)
[415.691659] [094/133] (622s left) api_intel_bb (render-ccs)
[415.737282] Starting subtest: render-ccs
[416.084316] Subtest render-ccs: SUCCESS (0.348s)
[416.169993] [095/133] (622s left) kms_flip (plain-flip-fb-recreate)
[416.258605] Starting subtest: plain-flip-fb-recreate
[416.261003] Starting dynamic subtest: A-eDP1
[425.141713] Dynamic subtest A-eDP1: SUCCESS (8.881s)
[425.151394] Starting dynamic subtest: B-eDP1
[433.980204] Dynamic subtest B-eDP1: SUCCESS (8.835s)
[433.992359] Starting dynamic subtest: C-eDP1
[442.812041] Dynamic subtest C-eDP1: SUCCESS (8.829s)
[442.821964] Starting dynamic subtest: D-eDP1
[451.648607] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[451.653071] Subtest plain-flip-fb-recreate: SUCCESS (35.390s)
[452.827545] [096/133] (585s left) kms_color (ctm-green-to-red)
[452.924321] Starting subtest: ctm-green-to-red
[452.927081] Starting dynamic subtest: pipe-A-eDP-1
[453.619980] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[453.632285] Starting dynamic subtest: pipe-B-eDP-1
[455.015248] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s)
[455.026741] Starting dynamic subtest: pipe-C-eDP-1
[456.379970] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s)
[456.393290] Starting dynamic subtest: pipe-D-eDP-1
[457.715367] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[457.717985] Subtest ctm-green-to-red: SUCCESS (4.792s)
[458.545724] [097/133] (579s left) sysfs_heartbeat_interval (idempotent)
[458.613412] Starting subtest: idempotent
[458.616183] Starting dynamic subtest: vecs0
[458.618981] Dynamic subtest vecs0: SUCCESS (0.002s)
[458.629531] Starting dynamic subtest: ccs0
[458.632256] Dynamic subtest ccs0: SUCCESS (0.002s)
[458.642478] Starting dynamic subtest: vcs0
[458.645019] Dynamic subtest vcs0: SUCCESS (0.001s)
[458.655496] Starting dynamic subtest: bcs0
[458.658324] Dynamic subtest bcs0: SUCCESS (0.002s)
[458.669123] Starting dynamic subtest: rcs0
[458.671321] Dynamic subtest rcs0: SUCCESS (0.002s)
[458.681516] Starting dynamic subtest: vcs1
[458.683950] Dynamic subtest vcs1: SUCCESS (0.001s)
[458.686200] Subtest idempotent: SUCCESS (0.025s)
[458.729653] [098/133] (579s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[458.830671] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[458.835910] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[458.935882] [099/133] (579s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[459.037194] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[460.116349] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.079s)
[460.236680] [100/133] (578s left) gem_mmap_wc (write-read-distinct)
[460.296794] Subtest write-read-distinct: SKIP (0.000s)
[460.357653] [101/133] (578s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[460.447068] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[460.449090] Starting dynamic subtest: pipe-A-eDP-1
[460.466424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[460.477064] Starting dynamic subtest: pipe-B-eDP-1
[460.495086] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[460.505131] Starting dynamic subtest: pipe-C-eDP-1
[460.523072] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[460.532950] Starting dynamic subtest: pipe-D-eDP-1
[460.549977] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[460.551923] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[462.705653] [102/133] (575s left) gem_ctx_persistence (heartbeat-many)
[462.771119] Starting subtest: heartbeat-many
[462.775932] Subtest heartbeat-many: SKIP (0.000s)
[462.868235] [103/133] (575s left) kms_lease (multimaster-lease)
[462.964155] Starting subtest: multimaster-lease
[462.966515] Subtest multimaster-lease: SUCCESS (0.003s)
[463.077288] [104/133] (575s left) syncobj_timeline (single-wait-signaled)
[463.135343] Starting subtest: single-wait-signaled
[463.137756] Subtest single-wait-signaled: SUCCESS (0.000s)
[463.230947] [105/133] (575s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[463.286045] Starting subtest: multi-wait-all-available-submitted-signaled
[463.288547] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[463.377040] [106/133] (575s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[463.471942] Starting subtest: addfb25-y-tiled-legacy
[463.474387] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[463.571835] [107/133] (575s left) perf_pmu (idle)
[463.620431] Starting subtest: idle
[463.623504] Starting dynamic subtest: rcs0
[464.156822] Dynamic subtest rcs0: SUCCESS (0.537s)
[464.171525] Starting dynamic subtest: bcs0
[464.671960] Dynamic subtest bcs0: SUCCESS (0.513s)
[464.685518] Starting dynamic subtest: vcs0
[465.186695] Dynamic subtest vcs0: SUCCESS (0.513s)
[465.200260] Starting dynamic subtest: vcs1
[465.706048] Dynamic subtest vcs1: SUCCESS (0.516s)
[465.719498] Starting dynamic subtest: vecs0
[466.231893] Dynamic subtest vecs0: SUCCESS (0.523s)
[466.245495] Starting dynamic subtest: ccs0
[466.749307] Dynamic subtest ccs0: SUCCESS (0.515s)
[466.752406] Subtest idle: SUCCESS (3.132s)
[466.843003] [108/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[466.951827] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[474.385138] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.438s)
[474.522381] [109/133] (564s left) gem_exec_whisper (basic-contexts-priority-all)
[474.586108] Starting subtest: basic-contexts-priority-all
[497.478938] Subtest basic-contexts-priority-all: SUCCESS (22.891s)
[497.668352] [110/133] (541s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[497.783197] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[505.049715] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.270s)
[505.174049] [111/133] (533s left) gem_render_copy (y-tiled-ccs-to-linear)
[505.235309] Starting subtest: y-tiled-ccs-to-linear
[505.240986] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[505.433105] [112/133] (533s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[505.533523] Starting subtest: y-tiled-8bpp-rotate-180
[505.538469] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[505.635482] [113/133] (533s left) i915_query (hwconfig_table)
[505.679269] Starting subtest: hwconfig_table
[506.034404] Subtest hwconfig_table: SUCCESS (0.001s)
[506.077506] [114/133] (532s left) kms_plane (plane-panning-bottom-right-suspend)
[506.169405] Starting subtest: plane-panning-bottom-right-suspend
[506.172203] Starting dynamic subtest: pipe-A
[523.660666] Dynamic subtest pipe-A: SUCCESS (2.820s)
[523.672083] Starting dynamic subtest: pipe-B
[541.662705] Dynamic subtest pipe-B: SUCCESS (3.466s)
[541.665599] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.288s)
[542.455644] [115/133] (496s left) kms_atomic (plane-invalid-params)
[542.554255] Starting subtest: plane-invalid-params
[542.556765] Starting dynamic subtest: pipe-A-eDP-1
[542.954724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.401s)
[542.957745] Subtest plane-invalid-params: SUCCESS (0.402s)
[543.786529] [116/133] (495s left) gem_exec_fence (syncobj-repeat)
[544.294995] Starting subtest: syncobj-repeat
[544.482613] Subtest syncobj-repeat: SUCCESS (0.185s)
[545.524249] [117/133] (493s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[545.611457] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[545.616479] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[545.687743] [118/133] (493s left) perf (rc6-disable)
[545.830383] Starting subtest: rc6-disable
[546.004348] Subtest rc6-disable: SUCCESS (0.175s)
[546.053827] [119/133] (493s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[546.142778] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[546.148182] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[546.239363] [120/133] (493s left) kms_flip (2x-dpms-vs-vblank-race)
[546.336656] Starting subtest: 2x-dpms-vs-vblank-race
[546.346880] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[546.428424] [121/133] (492s left) sw_sync (sync_multi_timeline_wait)
[546.467714] Starting subtest: sync_multi_timeline_wait
[546.470526] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[546.526853] [122/133] (492s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[546.581373] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[546.691475] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[546.768112] [123/133] (492s left) kms_psr (fbc-pr-primary-mmap-gtt)
[546.865239] Starting subtest: fbc-pr-primary-mmap-gtt
[546.869863] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[546.938722] [124/133] (492s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[547.040170] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[547.045007] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[547.131728] [125/133] (492s left) kms_pm_rpm (dpms-lpsp)
[548.658897] Starting subtest: dpms-lpsp
[549.376885] Subtest dpms-lpsp: SUCCESS (0.718s)
[549.469678] [126/133] (490s left) kms_flip (flip-vs-dpms-on-nop)
[549.565985] Starting subtest: flip-vs-dpms-on-nop
[549.568447] Starting dynamic subtest: A-eDP1
[551.430513] Dynamic subtest A-eDP1: SUCCESS (1.863s)
[551.441772] Starting dynamic subtest: B-eDP1
[553.269556] Dynamic subtest B-eDP1: SUCCESS (1.834s)
[553.283466] Starting dynamic subtest: C-eDP1
[555.099897] Dynamic subtest C-eDP1: SUCCESS (1.826s)
[555.112824] Starting dynamic subtest: D-eDP1
[556.930948] Dynamic subtest D-eDP1: SUCCESS (1.826s)
[556.933327] Subtest flip-vs-dpms-on-nop: SUCCESS (7.361s)
[558.126130] [127/133] (481s left) gem_exec_balancer (parallel-balancer)
[558.394879] Starting subtest: parallel-balancer
[559.276993] Subtest parallel-balancer: SUCCESS (0.885s)
[559.390746] [128/133] (480s left) kms_big_fb (linear-32bpp-rotate-270)
[559.486967] Starting subtest: linear-32bpp-rotate-270
[559.507230] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[559.625311] [129/133] (480s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[559.723431] Starting subtest: plane-all-transition-nonblocking-fencing
[559.726010] Starting dynamic subtest: pipe-A-eDP-1
[562.220149] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[562.531566] Starting dynamic subtest: pipe-B-eDP-1
[565.756302] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.233s)
[566.057488] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.329s)
[566.891042] [130/133] (472s left) gem_ctx_exec (basic-invalid-context)
[566.951453] Starting subtest: basic-invalid-context
[566.953574] Subtest basic-invalid-context: SUCCESS (0.005s)
[567.072039] [131/133] (472s left) kms_mmap_write_crc (main)
[567.170697] Starting subtest: main
[567.173126] Starting dynamic subtest: pipe-A-eDP-1
[570.654965] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.483s)
[570.657783] Subtest main: SUCCESS (3.484s)
[571.550845] [132/133] (468s left) perf_pmu (semaphore-wait)
[571.597403] Starting subtest: semaphore-wait
[571.599778] Starting dynamic subtest: rcs0
[572.110345] Dynamic subtest rcs0: SUCCESS (0.513s)
[572.124985] Starting dynamic subtest: bcs0
[572.625316] Dynamic subtest bcs0: SUCCESS (0.511s)
[572.639740] Starting dynamic subtest: vcs0
[573.139127] Dynamic subtest vcs0: SUCCESS (0.510s)
[573.153798] Starting dynamic subtest: vcs1
[573.653082] Dynamic subtest vcs1: SUCCESS (0.510s)
[573.667429] Starting dynamic subtest: vecs0
[574.166724] Dynamic subtest vecs0: SUCCESS (0.510s)
[574.181578] Starting dynamic subtest: ccs0
[574.684092] Dynamic subtest ccs0: SUCCESS (0.513s)
[574.687074] Subtest semaphore-wait: SUCCESS (3.087s)
[574.804031] [133/133] (465s left) kms_frontbuffer_tracking (psr-suspend)
[574.915403] Starting subtest: psr-suspend
[612.821434] Subtest psr-suspend: SUCCESS (7.973s)
[612.925913] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_vrr
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_cursor_edge_walk
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_exec_gttfill
results: parsing output: 8/ for test: i915_pm_freq_mult
results: parsing output: 9/ for test: gem_exec_suspend
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_chamelium_frames
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: syncobj_eventfd
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_ctx_exec
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: gem_tiled_pread_basic
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: kms_content_protection
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_pxp
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_draw_crc
results: parsing output: 51/ for test: tools_test
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_prop_blob
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: vgem_basic
results: parsing output: 60/ for test: kms_universal_plane
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: gem_mmap_offset
results: parsing output: 63/ for test: gen7_exec_parse
results: parsing output: 64/ for test: kms_invalid_mode
results: parsing output: 65/ for test: api_intel_allocator
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: prime_mmap_coherency
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_ctx_shared
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: i915_hangman
results: parsing output: 75/ for test: dmabuf_sync_file
results: parsing output: 76/ for test: gem_exec_flush
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gem_wait
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: gem_basic
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_chamelium_frames
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_color
results: parsing output: 96/ for test: sysfs_heartbeat_interval
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_atomic
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: sw_sync
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_atomic_transition
results: parsing output: 129/ for test: gem_ctx_exec
results: parsing output: 130/ for test: kms_mmap_write_crc
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.