[57.558418] Initializing watchdogs
[57.558468]   /dev/watchdog0
[57.572829] [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]
[57.577656] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.580182] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.583630] [001/133] (960s left) kms_psr (psr2-sprite-render)
[57.694786] Starting subtest: psr2-sprite-render
[57.697080] Starting dynamic subtest: eDP-1
[59.445791] Dynamic subtest eDP-1: SUCCESS (1.751s)
[59.448252] Subtest psr2-sprite-render: SUCCESS (1.751s)
[60.326690] [002/133] (957s left) kms_content_protection (dp-mst-type-0-hdcp14)
[60.461951] Starting subtest: dp-mst-type-0-hdcp14
[60.466811] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[60.578699] [003/133] (957s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[60.669951] Starting subtest: async-flip-with-page-flip-events-linear
[61.041600] Starting dynamic subtest: pipe-A-eDP-1
[63.786290] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.743s)
[64.154145] Starting dynamic subtest: pipe-B-eDP-1
[66.919473] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.769s)
[67.281649] Starting dynamic subtest: pipe-C-eDP-1
[70.043066] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.766s)
[70.412120] Starting dynamic subtest: pipe-D-eDP-1
[73.174763] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[73.177227] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.504s)
[74.365213] [004/133] (943s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[74.616157] Starting subtest: cursor-rapid-movement-512x512
[74.620765] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[74.773748] [005/133] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[74.870294] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[74.874483] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[74.964045] [006/133] (943s left) i915_selftest (live)
[76.665809] Starting subtest: live
[76.668412] Starting dynamic subtest: sanitycheck
[80.906316] Dynamic subtest sanitycheck: SUCCESS (4.241s)
[80.914354] Starting dynamic subtest: uncore
[85.181310] Dynamic subtest uncore: SUCCESS (4.274s)
[85.194829] Starting dynamic subtest: workarounds
[88.241022] Dynamic subtest workarounds: SUCCESS (3.059s)
[88.248285] Starting dynamic subtest: gt_engines
[91.188460] Dynamic subtest gt_engines: SUCCESS (2.946s)
[91.197151] Starting dynamic subtest: gt_timelines
[107.066182] Dynamic subtest gt_timelines: SUCCESS (15.877s)
[107.074067] Starting dynamic subtest: gt_contexts
[111.344710] Dynamic subtest gt_contexts: SUCCESS (4.278s)
[111.352325] Starting dynamic subtest: gt_lrc
[115.600171] Dynamic subtest gt_lrc: SUCCESS (4.255s)
[115.607897] Starting dynamic subtest: gt_mocs
[118.525494] Dynamic subtest gt_mocs: SUCCESS (2.924s)
[118.533687] Starting dynamic subtest: gt_pm
[125.165799] Dynamic subtest gt_pm: SUCCESS (6.639s)
[125.174381] Starting dynamic subtest: gt_heartbeat
[127.851052] Dynamic subtest gt_heartbeat: SUCCESS (2.684s)
[127.857430] Starting dynamic subtest: gt_tlb
[137.156069] Dynamic subtest gt_tlb: SUCCESS (9.303s)
[137.167311] Starting dynamic subtest: requests
[150.483418] Dynamic subtest requests: SUCCESS (13.325s)
[150.492294] Starting dynamic subtest: migrate
[158.165964] Dynamic subtest migrate: SUCCESS (7.681s)
[158.174955] Starting dynamic subtest: active
[162.519067] Dynamic subtest active: SUCCESS (4.352s)
[162.528307] Starting dynamic subtest: objects
[167.202037] Dynamic subtest objects: SUCCESS (4.681s)
[167.210732] Starting dynamic subtest: mman
[171.941777] Dynamic subtest mman: SUCCESS (4.739s)
[171.950426] Starting dynamic subtest: dmabuf
[176.278667] Dynamic subtest dmabuf: SUCCESS (4.336s)
[176.292882] Starting dynamic subtest: vma
[180.625066] Dynamic subtest vma: SUCCESS (4.344s)
[180.634047] Starting dynamic subtest: coherency
[184.132600] Dynamic subtest coherency: SUCCESS (3.506s)
[184.140044] Starting dynamic subtest: gtt
[193.946838] Dynamic subtest gtt: SUCCESS (9.812s)
[193.955852] Starting dynamic subtest: gem
[199.625711] Dynamic subtest gem: SUCCESS (5.678s)
[199.635626] Starting dynamic subtest: evict
[203.518412] Dynamic subtest evict: SUCCESS (3.892s)
[203.527316] Starting dynamic subtest: hugepages
[212.242805] Dynamic subtest hugepages: SUCCESS (8.723s)
[212.251818] Starting dynamic subtest: gem_contexts
[241.456032] Dynamic subtest gem_contexts: SUCCESS (29.211s)
[241.464698] Starting dynamic subtest: client
[245.761056] Dynamic subtest client: SUCCESS (4.304s)
[245.775101] Starting dynamic subtest: gem_migrate
[250.034194] Dynamic subtest gem_migrate: SUCCESS (4.271s)
[250.047259] Starting dynamic subtest: reset
[254.304489] Dynamic subtest reset: SUCCESS (4.268s)
[254.313125] Starting dynamic subtest: memory_region
[258.653750] Dynamic subtest memory_region: SUCCESS (4.348s)
[258.662828] Starting dynamic subtest: hangcheck
[271.410628] Dynamic subtest hangcheck: SUCCESS (12.756s)
[271.419816] Starting dynamic subtest: execlists
[275.961329] Dynamic subtest execlists: SUCCESS (4.549s)
[275.970168] Starting dynamic subtest: ring_submission
[280.205357] Dynamic subtest ring_submission: SUCCESS (4.242s)
[280.214481] Starting dynamic subtest: perf
[284.479281] Dynamic subtest perf: SUCCESS (4.273s)
[284.492124] Starting dynamic subtest: slpc
[298.423490] Dynamic subtest slpc: SUCCESS (13.942s)
[298.431925] Starting dynamic subtest: guc
[302.297392] Dynamic subtest guc: SUCCESS (3.872s)
[302.306288] Starting dynamic subtest: guc_multi_lrc
[306.650636] Dynamic subtest guc_multi_lrc: SUCCESS (4.351s)
[306.659119] Starting dynamic subtest: guc_hang
[311.488348] Dynamic subtest guc_hang: SUCCESS (4.836s)
[311.497303] Starting dynamic subtest: late_gt_pm
[314.137447] Dynamic subtest late_gt_pm: SUCCESS (2.648s)
[314.140052] Subtest live: SUCCESS (237.463s)
[314.167361] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[314.170586] [007/133] (704s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[315.748347] Starting subtest: 2x-long-cursor-vs-flip-legacy
[315.752751] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[315.933524] [FACT kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)] new: kernel.kmod_is_loaded.i915: true
[315.937230] [008/133] (702s left) kms_joiner (invalid-modeset-big-joiner)
[316.030647] Starting subtest: invalid-modeset-big-joiner
[316.034607] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[316.099239] [009/133] (702s left) kms_psr (psr-sprite-mmap-gtt)
[316.191020] Starting subtest: psr-sprite-mmap-gtt
[316.193327] Starting dynamic subtest: eDP-1
[317.681584] Dynamic subtest eDP-1: SKIP (1.488s)
[317.686313] Subtest psr-sprite-mmap-gtt: SKIP (1.490s)
[317.856650] [010/133] (700s left) gem_exec_flush (basic-wb-pro-default)
[317.927732] Starting subtest: basic-wb-pro-default
[323.396298] Subtest basic-wb-pro-default: SUCCESS (5.467s)
[323.604480] [011/133] (694s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[323.730659] Starting subtest: cursorB-vs-flipA-varying-size
[323.735422] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[323.869848] [012/133] (694s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[323.969467] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[323.973689] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[324.062834] [013/133] (694s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[324.113968] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[324.118408] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[324.293240] [014/133] (694s left) gem_mmap_wc (bad-object)
[324.350736] Subtest bad-object: SKIP (0.000s)
[324.426876] [015/133] (694s left) perf (enable-disable)
[324.553045] Starting subtest: enable-disable
[324.557828] Starting dynamic subtest: 0-rcs0
[326.816671] Dynamic subtest 0-rcs0: SUCCESS (2.264s)
[326.824647] Starting dynamic subtest: 1-vcs1
[331.282402] Dynamic subtest 1-vcs1: SUCCESS (4.465s)
[331.284822] Subtest enable-disable: SUCCESS (6.731s)
[331.328282] [016/133] (687s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[331.425443] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[331.429443] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[331.521489] [017/133] (687s left) kms_flip (nonexisting-fb-interruptible)
[331.616403] Starting subtest: nonexisting-fb-interruptible
[331.618625] Starting dynamic subtest: A-eDP1
[332.800751] Dynamic subtest A-eDP1: SUCCESS (1.183s)
[332.811102] Starting dynamic subtest: B-eDP1
[333.916623] Dynamic subtest B-eDP1: SUCCESS (1.113s)
[333.926706] Starting dynamic subtest: C-eDP1
[335.047380] Dynamic subtest C-eDP1: SUCCESS (1.127s)
[335.056787] Starting dynamic subtest: D-eDP1
[336.177840] Dynamic subtest D-eDP1: SUCCESS (1.132s)
[336.182875] Subtest nonexisting-fb-interruptible: SUCCESS (4.568s)
[337.346116] [018/133] (681s left) kms_cursor_crc (cursor-offscreen-64x21)
[337.530047] Starting subtest: cursor-offscreen-64x21
[337.573238] Subtest cursor-offscreen-64x21: SKIP (0.039s)
[337.795779] [019/133] (680s left) kms_atomic_transition (modeset-transition-fencing)
[337.883509] Starting subtest: modeset-transition-fencing
[337.885668] Starting dynamic subtest: 1x-outputs
[348.709290] Dynamic subtest 1x-outputs: SUCCESS (10.826s)
[348.711850] Subtest modeset-transition-fencing: SUCCESS (10.828s)
[349.579783] [020/133] (669s left) kms_cursor_legacy (forked-bo)
[349.690491] Starting subtest: forked-bo
[349.692807] Starting dynamic subtest: pipe-A
[355.168632] Dynamic subtest pipe-A: SUCCESS (5.475s)
[355.177795] Starting dynamic subtest: pipe-B
[360.636336] Dynamic subtest pipe-B: SUCCESS (5.465s)
[360.647377] Starting dynamic subtest: pipe-C
[366.110179] Dynamic subtest pipe-C: SUCCESS (5.471s)
[366.119097] Starting dynamic subtest: pipe-D
[371.590360] Dynamic subtest pipe-D: SUCCESS (5.477s)
[371.600275] Starting dynamic subtest: all-pipes
[377.088684] Dynamic subtest all-pipes: SUCCESS (5.495s)
[377.091227] Subtest forked-bo: SUCCESS (27.396s)
[377.233416] [021/133] (641s left) gem_exec_balancer (full-late)
[377.313529] Starting subtest: full-late
[381.744219] Subtest full-late: SUCCESS (4.431s)
[382.059083] [022/133] (636s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[382.162384] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[382.166247] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[382.259258] [023/133] (636s left) gem_exec_reloc (basic-write-read)
[382.322509] Subtest basic-write-read: SKIP (0.000s)
[382.391480] [024/133] (636s left) gem_softpin (allocator-fork)
[382.452894] Starting subtest: allocator-fork
[384.669513] Subtest allocator-fork: SUCCESS (2.216s)
[384.807471] [025/133] (634s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[384.912985] Starting subtest: plane-lut1d-ctm3x4
[385.048235] Starting dynamic subtest: pipe-A-plane-0
[385.249178] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[385.260225] Starting dynamic subtest: pipe-A-plane-1
[385.381603] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[385.390129] Starting dynamic subtest: pipe-A-plane-2
[385.515090] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s)
[386.685816] Starting dynamic subtest: pipe-B-plane-0
[386.834880] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[386.843484] Starting dynamic subtest: pipe-B-plane-1
[386.968072] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[386.976493] Starting dynamic subtest: pipe-B-plane-2
[387.112394] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[388.305758] Starting dynamic subtest: pipe-C-plane-0
[388.432359] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[388.441442] Starting dynamic subtest: pipe-C-plane-1
[388.576560] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[388.585479] Starting dynamic subtest: pipe-C-plane-2
[388.721432] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[389.954288] Starting dynamic subtest: pipe-D-plane-0
[390.078485] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[390.087442] Starting dynamic subtest: pipe-D-plane-1
[390.211868] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[390.220356] Starting dynamic subtest: pipe-D-plane-2
[390.345089] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s)
[390.633039] Subtest plane-lut1d-ctm3x4: SUCCESS (5.718s)
[391.516603] [026/133] (627s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[391.615369] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[391.641523] Starting dynamic subtest: pipe-A-plane-0
[392.087352] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[392.095674] Starting dynamic subtest: pipe-A-plane-3
[392.341593] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[392.350076] Starting dynamic subtest: pipe-A-plane-5
[392.354101] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[393.410438] Starting dynamic subtest: pipe-B-plane-0
[393.808109] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[393.818796] Starting dynamic subtest: pipe-B-plane-3
[394.086090] Dynamic subtest pipe-B-plane-3: SUCCESS (0.274s)
[394.095135] Starting dynamic subtest: pipe-B-plane-5
[394.099539] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[394.393741] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.779s)
[395.279221] [027/133] (623s left) kms_lease (lease-invalid-plane)
[395.381038] Starting subtest: lease-invalid-plane
[395.383264] Starting dynamic subtest: pipe-A-eDP-1
[395.385421] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[395.393777] Starting dynamic subtest: pipe-B-eDP-1
[395.395661] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[395.403523] Starting dynamic subtest: pipe-C-eDP-1
[395.405709] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[395.413513] Starting dynamic subtest: pipe-D-eDP-1
[395.415397] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[395.417286] Subtest lease-invalid-plane: SUCCESS (0.004s)
[395.462706] [028/133] (623s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[395.525426] Starting subtest: single-wait-all-for-submit-unsubmitted
[395.632824] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[395.716606] [029/133] (623s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[395.820816] Starting subtest: psr-2p-pri-indfb-multidraw
[395.825276] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[395.916503] [030/133] (623s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[396.010067] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[396.014128] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[396.102599] [031/133] (623s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[396.497655] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[397.288928] [032/133] (622s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[397.395911] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[397.399694] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[397.487193] [033/133] (621s left) kms_vrr (flip-basic)
[397.587310] Starting subtest: flip-basic
[397.593691] Subtest flip-basic: SKIP (0.000s)
[397.655523] [034/133] (621s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[397.760968] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[397.765220] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[397.847646] [035/133] (621s left) kms_psr (pr-primary-mmap-cpu)
[397.938081] Starting subtest: pr-primary-mmap-cpu
[397.942308] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[398.009776] [036/133] (621s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[398.099225] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[398.101351] Starting dynamic subtest: pipe-A-eDP-1
[414.458360] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.482s)
[414.468122] Starting dynamic subtest: pipe-B-eDP-1
[431.408983] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.434s)
[431.418001] Starting dynamic subtest: pipe-C-eDP-1
[448.385259] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.373s)
[448.393925] Starting dynamic subtest: pipe-D-eDP-1
[465.383679] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.386s)
[465.385914] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.681s)
[466.507004] [037/133] (552s left) prime_mmap (test_map_unmap)
[466.564620] Starting subtest: test_map_unmap
[466.566791] Starting dynamic subtest: test_map_unmap-smem
[466.593347] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[466.595693] Subtest test_map_unmap: SUCCESS (0.032s)
[466.681084] [038/133] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[466.780715] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[474.038003] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.408s)
[474.193487] [039/133] (545s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[474.302564] Starting subtest: x-tiled-8bpp-rotate-180
[475.458770] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.169s)
[475.576033] [040/133] (544s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[475.675812] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[475.677591] Starting dynamic subtest: pipe-A-eDP-1
[481.526067] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.891s)
[481.535845] Starting dynamic subtest: pipe-B-eDP-1
[488.174861] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.668s)
[488.177247] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.562s)
[489.024694] [041/133] (530s left) kms_draw_crc (draw-method-mmap-cpu)
[489.124365] Starting subtest: draw-method-mmap-cpu
[489.126228] Starting dynamic subtest: xrgb8888-untiled
[489.344600] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[489.353220] Starting dynamic subtest: rgb565-untiled
[489.555106] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[489.565623] Starting dynamic subtest: xrgb2101010-untiled
[489.766788] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[489.775954] Starting dynamic subtest: xbgr16161616f-untiled
[489.976485] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[489.985056] Starting dynamic subtest: xrgb8888-xtiled
[490.097932] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[490.106769] Starting dynamic subtest: rgb565-xtiled
[490.220310] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[490.229673] Starting dynamic subtest: xrgb2101010-xtiled
[490.330995] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[490.344206] Starting dynamic subtest: xbgr16161616f-xtiled
[490.464224] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[490.474548] Starting dynamic subtest: xrgb8888-4tiled
[490.597540] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[490.606425] Starting dynamic subtest: rgb565-4tiled
[490.731110] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[490.754475] Starting dynamic subtest: xrgb2101010-4tiled
[490.885530] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.152s)
[490.894924] Starting dynamic subtest: xbgr16161616f-4tiled
[491.018795] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[491.020683] Subtest draw-method-mmap-cpu: SUCCESS (1.900s)
[491.100310] [042/133] (528s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[491.165468] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[491.167173] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[491.276863] [043/133] (528s left) kms_cursor_crc (cursor-sliding-max-size)
[491.595376] Starting subtest: cursor-sliding-max-size
[491.600728] Subtest cursor-sliding-max-size: SKIP (0.000s)
[491.710385] [044/133] (528s left) kms_flip (blocking-absolute-wf_vblank)
[491.820165] Starting subtest: blocking-absolute-wf_vblank
[491.822201] Starting dynamic subtest: A-eDP1
[500.593596] Dynamic subtest A-eDP1: SUCCESS (8.771s)
[500.611735] Starting dynamic subtest: B-eDP1
[509.336168] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[509.349215] Starting dynamic subtest: C-eDP1
[518.063347] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[518.080913] Starting dynamic subtest: D-eDP1
[526.791476] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[526.797044] Subtest blocking-absolute-wf_vblank: SUCCESS (34.967s)
[527.999116] [045/133] (491s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[528.089853] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[528.093901] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[528.184252] [046/133] (491s left) kms_psr (fbc-pr-sprite-render)
[528.272481] Starting subtest: fbc-pr-sprite-render
[528.276920] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[528.343508] [047/133] (491s left) sysfs_defaults (readonly)
[528.398270] Starting subtest: readonly
[528.400561] Starting dynamic subtest: vecs0
[528.402735] Dynamic subtest vecs0: SUCCESS (0.000s)
[528.412232] Starting dynamic subtest: ccs0
[528.414349] Dynamic subtest ccs0: SUCCESS (0.000s)
[528.423187] Starting dynamic subtest: vcs0
[528.425246] Dynamic subtest vcs0: SUCCESS (0.000s)
[528.433636] Starting dynamic subtest: bcs0
[528.435664] Dynamic subtest bcs0: SUCCESS (0.000s)
[528.443859] Starting dynamic subtest: rcs0
[528.445673] Dynamic subtest rcs0: SUCCESS (0.000s)
[528.454098] Starting dynamic subtest: vcs1
[528.456188] Dynamic subtest vcs1: SUCCESS (0.000s)
[528.458253] Subtest readonly: SUCCESS (0.006s)
[528.497285] [048/133] (491s left) kms_pm_backlight (bad-brightness)
[528.576965] Starting subtest: bad-brightness
[528.625428] Starting dynamic subtest: eDP-1
[528.947939] Dynamic subtest eDP-1: SUCCESS (0.321s)
[528.950188] Subtest bad-brightness: SUCCESS (0.372s)
[529.753190] [049/133] (490s left) kms_psr (fbc-psr2-sprite-render)
[529.836503] Starting subtest: fbc-psr2-sprite-render
[529.838828] Starting dynamic subtest: eDP-1
[529.843083] Dynamic subtest eDP-1: SKIP (0.000s)
[529.847244] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[529.907927] [050/133] (490s left) gem_mmap_offset (partial-mmap)
[529.964509] Starting subtest: partial-mmap
[529.967001] Starting dynamic subtest: smem0
[529.969366] Dynamic subtest smem0: SUCCESS (0.004s)
[529.971353] Subtest partial-mmap: SUCCESS (0.005s)
[530.103345] [051/133] (489s left) gem_exec_fence (basic-wait-all)
[530.155010] Starting subtest: basic-wait-all
[530.231209] Subtest basic-wait-all: SUCCESS (0.077s)
[531.800917] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[531.804292] [052/133] (488s left) kms_plane_scaling (2x-scaler-multi-pipe)
[531.907677] Starting subtest: 2x-scaler-multi-pipe
[531.912323] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[532.032116] [053/133] (488s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[532.148753] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[532.795166] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.648s)
[532.935534] [054/133] (487s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[533.048503] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[533.052918] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[533.145477] [055/133] (487s left) gem_vm_create (invalid-create)
[533.210049] Starting subtest: invalid-create
[533.215415] Subtest invalid-create: SUCCESS (0.002s)
[533.313847] [056/133] (486s left) gen3_render_linear_blits
[533.438608] [057/133] (486s left) drm_read (short-buffer-block)
[533.589266] Starting subtest: short-buffer-block
[533.591528] Subtest short-buffer-block: SUCCESS (0.000s)
[533.725222] [058/133] (486s left) dmabuf_sync_file (import-multiple-read-only)
[533.766513] Starting subtest: import-multiple-read-only
[533.768397] Subtest import-multiple-read-only: SUCCESS (0.003s)
[533.822628] [059/133] (486s left) gem_exec_schedule (noreorder-corked)
[533.994934] Starting subtest: noreorder-corked
[533.997522] Starting dynamic subtest: rcs0
[535.137499] Dynamic subtest rcs0: SUCCESS (1.143s)
[535.150410] Starting dynamic subtest: vcs0
[536.743509] Dynamic subtest vcs0: SUCCESS (1.603s)
[536.755627] Starting dynamic subtest: vcs1
[538.722605] Dynamic subtest vcs1: SUCCESS (1.977s)
[538.733848] Starting dynamic subtest: vecs0
[540.763817] Dynamic subtest vecs0: SUCCESS (2.039s)
[540.775905] Starting dynamic subtest: ccs0
[541.906425] Dynamic subtest ccs0: SUCCESS (1.141s)
[541.909120] Subtest noreorder-corked: SUCCESS (7.915s)
[542.111712] [060/133] (478s left) kms_getfb (getfb2-handle-zero)
[542.210420] Starting subtest: getfb2-handle-zero
[542.212647] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[542.314950] [061/133] (478s left) perf_pmu (init-sema)
[542.368935] Starting subtest: init-sema
[542.371219] Starting dynamic subtest: rcs0
[542.373530] Dynamic subtest rcs0: SUCCESS (0.001s)
[542.386381] Starting dynamic subtest: bcs0
[542.388358] Dynamic subtest bcs0: SUCCESS (0.000s)
[542.399282] Starting dynamic subtest: vcs0
[542.401157] Dynamic subtest vcs0: SUCCESS (0.001s)
[542.410777] Starting dynamic subtest: vcs1
[542.412876] Dynamic subtest vcs1: SUCCESS (0.000s)
[542.421769] Starting dynamic subtest: vecs0
[542.423628] Dynamic subtest vecs0: SUCCESS (0.000s)
[542.432774] Starting dynamic subtest: ccs0
[542.434647] Dynamic subtest ccs0: SUCCESS (0.000s)
[542.436512] Subtest init-sema: SUCCESS (0.008s)
[542.477977] [062/133] (478s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[542.600678] Starting subtest: 2x-cursor-vs-flip-atomic
[542.605094] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[542.745481] [063/133] (477s left) gem_exec_params (dr1-dirt)
[542.799321] Starting subtest: DR1-dirt
[542.801613] Subtest DR1-dirt: SUCCESS (0.000s)
[542.897141] [064/133] (477s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[543.007401] Starting subtest: 2x-long-flip-vs-cursor-atomic
[543.011946] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[543.152495] [065/133] (477s left) gem_partial_pwrite_pread (write-display)
[543.206816] Subtest write-display: SKIP (0.000s)
[543.286483] [066/133] (477s left) api_intel_bb (render)
[543.343077] Starting subtest: render
[543.344781] Starting dynamic subtest: render-none-512
[543.461308] Dynamic subtest render-none-512: SUCCESS (0.118s)
[543.473232] Starting dynamic subtest: render-none-1024
[543.901993] Dynamic subtest render-none-1024: SUCCESS (0.439s)
[543.914831] Starting dynamic subtest: render-x-512
[544.011001] Dynamic subtest render-x-512: SUCCESS (0.109s)
[544.022860] Starting dynamic subtest: render-x-1024
[544.407651] Dynamic subtest render-x-1024: SUCCESS (0.395s)
[544.417463] Starting dynamic subtest: render-y-512
[544.506892] Dynamic subtest render-y-512: SUCCESS (0.099s)
[544.517386] Starting dynamic subtest: render-y-1024
[544.903472] Dynamic subtest render-y-1024: SUCCESS (0.393s)
[544.906476] Subtest render: SUCCESS (1.561s)
[545.012138] [067/133] (475s left) gem_exec_schedule (timeslicing)
[545.083463] Starting subtest: timeslicing
[545.085800] Starting dynamic subtest: rcs0
[545.093593] Dynamic subtest rcs0: SUCCESS (0.021s)
[545.103943] Starting dynamic subtest: bcs0
[545.113256] Dynamic subtest bcs0: SUCCESS (0.020s)
[545.122122] Starting dynamic subtest: vcs0
[545.134265] Dynamic subtest vcs0: SUCCESS (0.020s)
[545.143236] Starting dynamic subtest: vcs1
[545.154416] Dynamic subtest vcs1: SUCCESS (0.019s)
[545.173144] Starting dynamic subtest: vecs0
[545.175760] Dynamic subtest vecs0: SUCCESS (0.019s)
[545.189331] Starting dynamic subtest: ccs0
[545.195022] Dynamic subtest ccs0: SUCCESS (0.019s)
[545.197281] Subtest timeslicing: SUCCESS (0.123s)
[546.767470] [068/133] (473s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[546.864291] Starting subtest: psr-rgb101010-draw-mmap-gtt
[546.868411] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[546.963350] [069/133] (473s left) prime_vgem (basic-gtt)
[547.043145] Starting subtest: basic-gtt
[547.047621] Subtest basic-gtt: SKIP (0.000s)
[547.154890] [070/133] (473s left) sriov_basic (bind-unbind-vf)
[547.196162] Starting subtest: bind-unbind-vf
[547.198124] Starting dynamic subtest: vf-1
[547.274042] Dynamic subtest vf-1: FAIL (0.012s)
[547.286486] Starting dynamic subtest: vf-2
[547.360301] Dynamic subtest vf-2: FAIL (0.004s)
[547.370891] Starting dynamic subtest: vf-3
[547.445016] Dynamic subtest vf-3: FAIL (0.003s)
[547.454919] Starting dynamic subtest: vf-4
[547.527705] Dynamic subtest vf-4: FAIL (0.004s)
[547.538078] Starting dynamic subtest: vf-5
[547.610477] Dynamic subtest vf-5: FAIL (0.003s)
[547.620599] Starting dynamic subtest: vf-6
[547.693426] Dynamic subtest vf-6: FAIL (0.003s)
[547.703389] Starting dynamic subtest: vf-7
[547.765338] Dynamic subtest vf-7: FAIL (0.003s)
[547.775352] Starting dynamic subtest: vf-random
[547.832414] Dynamic subtest vf-random: FAIL (0.003s)
[547.841676] Starting dynamic subtest: vf-last
[547.900660] Dynamic subtest vf-last: FAIL (0.509s)
[547.902621] Subtest bind-unbind-vf: FAIL (0.553s)
[547.941402] [071/133] (472s left) kms_chamelium_hpd (hdmi-hpd)
[548.336228] Subtest hdmi-hpd: SKIP (0.000s)
[549.177785] [072/133] (471s left) gem_userptr_blits (dmabuf-unsync)
[549.252662] Subtest dmabuf-unsync: SKIP (0.000s)
[549.390226] [073/133] (471s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[549.462101] Starting subtest: invalid-single-wait-all-unsubmitted
[549.464485] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[549.569672] [074/133] (471s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[549.674733] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[549.677005] Starting dynamic subtest: pipe-A-eDP-1
[549.702019] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[549.714292] Starting dynamic subtest: pipe-B-eDP-1
[549.739732] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[549.747976] Starting dynamic subtest: pipe-C-eDP-1
[549.771447] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[549.780072] Starting dynamic subtest: pipe-D-eDP-1
[549.804152] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[549.808542] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[551.928370] [075/133] (469s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[552.035239] Starting subtest: fbc-psr2-cursor-plane-update-sf
[552.037384] Starting dynamic subtest: pipe-A-eDP-1
[552.108141] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[552.118516] Starting dynamic subtest: pipe-B-eDP-1
[553.201849] Dynamic subtest pipe-B-eDP-1: SKIP (1.091s)
[553.206119] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.171s)
[554.387856] [076/133] (466s left) gem_eio (in-flight-immediate)
[554.647478] Starting subtest: in-flight-immediate
[563.292696] Subtest in-flight-immediate: SUCCESS (8.644s)
[563.426949] [077/133] (457s left) gen9_exec_parse (unaligned-jump)
[563.488270] Subtest unaligned-jump: SKIP (0.000s)
[563.562035] [078/133] (457s left) gem_ctx_isolation (clean)
[563.632488] Starting subtest: clean
[563.634786] Starting dynamic subtest: rcs0
[563.678898] Dynamic subtest rcs0: SUCCESS (0.046s)
[563.690623] Starting dynamic subtest: bcs0
[563.760505] Dynamic subtest bcs0: SUCCESS (0.080s)
[563.769651] Starting dynamic subtest: vcs0
[563.797256] Dynamic subtest vcs0: SUCCESS (0.036s)
[563.808599] Starting dynamic subtest: vcs1
[565.753324] Dynamic subtest vcs1: SUCCESS (1.954s)
[565.762849] Starting dynamic subtest: vecs0
[567.734885] Dynamic subtest vecs0: SUCCESS (1.979s)
[567.745605] Starting dynamic subtest: ccs0
[569.765761] Dynamic subtest ccs0: SUCCESS (2.029s)
[569.768864] Subtest clean: SUCCESS (6.131s)
[569.984883] [079/133] (451s left) gem_exec_fence (syncobj-repeat)
[570.434415] Starting subtest: syncobj-repeat
[570.628939] Subtest syncobj-repeat: SUCCESS (0.192s)
[571.854980] [080/133] (449s left) kms_pm_dc (dc5-dpms)
[572.948296] Starting subtest: dc5-dpms
[575.068602] Subtest dc5-dpms: SUCCESS (2.119s)
[575.148157] [081/133] (446s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[575.261152] Starting subtest: short-flip-before-cursor-toggle
[576.177087] Subtest short-flip-before-cursor-toggle: SUCCESS (0.915s)
[577.055416] [082/133] (444s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[577.161021] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[577.165284] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[577.280223] [083/133] (444s left) gem_ctx_shared (q-in-order)
[577.344314] Starting subtest: Q-in-order
[577.346698] Starting dynamic subtest: rcs0
[577.449163] Dynamic subtest rcs0: SUCCESS (0.104s)
[577.463554] Starting dynamic subtest: vcs0
[577.527285] Dynamic subtest vcs0: SUCCESS (0.076s)
[577.543460] Starting dynamic subtest: vcs1
[577.604157] Dynamic subtest vcs1: SUCCESS (0.076s)
[577.617546] Starting dynamic subtest: vecs0
[577.684219] Dynamic subtest vecs0: SUCCESS (0.079s)
[577.700703] Starting dynamic subtest: ccs0
[577.777205] Dynamic subtest ccs0: SUCCESS (0.092s)
[577.779735] Subtest Q-in-order: SUCCESS (0.434s)
[578.806332] [084/133] (442s left) kms_vblank (query-busy)
[578.908438] Starting subtest: query-busy
[578.910523] Starting dynamic subtest: pipe-A-eDP-1
[580.790604] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[580.805114] Starting dynamic subtest: pipe-D-eDP-1
[583.313437] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s)
[583.315905] Subtest query-busy: SUCCESS (4.407s)
[584.120033] [085/133] (437s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[584.212094] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[584.216252] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[584.315564] [086/133] (437s left) api_intel_bb (blit-reloc-keep-cache)
[584.382144] Starting subtest: blit-reloc-keep-cache
[584.386834] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[584.486218] [087/133] (437s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[584.594015] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[584.596286] Starting dynamic subtest: pipe-A-eDP-1
[584.618557] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[584.632414] Starting dynamic subtest: pipe-B-eDP-1
[584.652636] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[584.661693] Starting dynamic subtest: pipe-C-eDP-1
[584.682483] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[584.691389] Starting dynamic subtest: pipe-D-eDP-1
[584.712346] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[584.716223] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[586.879560] [088/133] (434s left) syncobj_wait (wait-delayed-signal)
[586.928286] Starting subtest: wait-delayed-signal
[587.031610] Subtest wait-delayed-signal: SUCCESS (0.102s)
[587.109073] [089/133] (434s left) gem_exec_nop (basic-parallel)
[587.186399] Starting subtest: basic-parallel
[603.684827] Subtest basic-parallel: SUCCESS (16.508s)
[603.915829] [090/133] (417s left) gem_exec_whisper (basic-contexts-priority)
[603.975343] Starting subtest: basic-contexts-priority
[627.243355] Subtest basic-contexts-priority: SUCCESS (23.266s)
[627.432527] [091/133] (394s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[627.482410] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[627.533180] [092/133] (394s left) gem_media_fill (media-fill)
[627.583646] Subtest media-fill: SKIP (0.000s)
[627.708242] [093/133] (394s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[627.808409] Starting subtest: nonblocking-crc-frame-sequence
[627.810448] Starting dynamic subtest: pipe-A-eDP-1
[628.546887] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[628.560265] Starting dynamic subtest: pipe-B-eDP-1
[629.985118] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.437s)
[629.998856] Starting dynamic subtest: pipe-C-eDP-1
[631.379463] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[631.392269] Starting dynamic subtest: pipe-D-eDP-1
[632.714820] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[632.717128] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.907s)
[633.509023] [094/133] (388s left) kms_plane_cursor (primary)
[633.606224] Starting subtest: primary
[633.610875] Starting dynamic subtest: pipe-A-eDP-1-size-64
[636.147081] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.544s)
[636.176602] Starting dynamic subtest: pipe-A-eDP-1-size-128
[638.724236] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[638.749416] Starting dynamic subtest: pipe-A-eDP-1-size-256
[641.313634] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[641.630488] Starting dynamic subtest: pipe-B-eDP-1-size-64
[644.908752] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.290s)
[644.932518] Starting dynamic subtest: pipe-B-eDP-1-size-128
[647.464895] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.539s)
[647.490268] Starting dynamic subtest: pipe-B-eDP-1-size-256
[650.031773] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.551s)
[650.347223] Starting dynamic subtest: pipe-C-eDP-1-size-64
[653.249000] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.913s)
[653.276790] Starting dynamic subtest: pipe-C-eDP-1-size-128
[655.447749] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[655.474672] Starting dynamic subtest: pipe-C-eDP-1-size-256
[657.670115] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[657.990387] Starting dynamic subtest: pipe-D-eDP-1-size-64
[660.885818] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.910s)
[660.913150] Starting dynamic subtest: pipe-D-eDP-1-size-128
[663.084802] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s)
[663.113194] Starting dynamic subtest: pipe-D-eDP-1-size-256
[665.296497] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.192s)
[665.602997] Subtest primary: SUCCESS (32.004s)
[666.464309] [095/133] (355s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[666.535048] Starting subtest: yf-tiled-ccs-to-x-tiled
[666.539792] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[666.720798] [096/133] (355s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[666.829484] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[666.833661] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[666.928039] [097/133] (355s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[667.032747] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[667.036768] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[667.107201] [098/133] (354s left) gem_ctx_persistence (heartbeat-hang)
[667.175813] Starting subtest: heartbeat-hang
[667.180818] Subtest heartbeat-hang: SKIP (0.000s)
[667.300371] [099/133] (354s left) i915_hangman (detector)
[667.375618] Starting subtest: detector
[667.377840] Starting dynamic subtest: rcs0
[678.721375] Dynamic subtest rcs0: SUCCESS (11.347s)
[678.733677] Starting dynamic subtest: bcs0
[689.734411] Dynamic subtest bcs0: SUCCESS (11.007s)
[689.746447] Starting dynamic subtest: vcs0
[701.635375] Dynamic subtest vcs0: SUCCESS (11.899s)
[701.647431] Starting dynamic subtest: vcs1
[711.682465] Dynamic subtest vcs1: SUCCESS (10.041s)
[711.694619] Starting dynamic subtest: vecs0
[722.689242] Dynamic subtest vecs0: SUCCESS (11.001s)
[722.701545] Starting dynamic subtest: ccs0
[733.697903] Dynamic subtest ccs0: SUCCESS (11.004s)
[733.700540] Subtest detector: SUCCESS (66.315s)
[733.817988] [100/133] (288s left) kms_big_fb (y-tiled-addfb-size-overflow)
[733.926504] Starting subtest: y-tiled-addfb-size-overflow
[733.930735] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[734.016308] [101/133] (288s left) gem_exec_create (legacy)
[734.077650] Starting subtest: legacy
[734.079949] Starting dynamic subtest: smem
[736.166364] Dynamic subtest smem: SUCCESS (2.090s)
[736.169124] Subtest legacy: SUCCESS (2.092s)
[736.353228] [102/133] (285s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[736.440435] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[736.442680] Starting dynamic subtest: pipe-A
[737.533126] Dynamic subtest pipe-A: SUCCESS (1.095s)
[737.545714] Starting dynamic subtest: pipe-B
[739.703617] Dynamic subtest pipe-B: SUCCESS (2.169s)
[739.717601] Starting dynamic subtest: pipe-C
[740.847240] Dynamic subtest pipe-C: SUCCESS (1.142s)
[740.858248] Starting dynamic subtest: pipe-D
[742.072667] Dynamic subtest pipe-D: SUCCESS (1.224s)
[742.075028] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.634s)
[743.265592] [103/133] (278s left) kms_vrr (lobf)
[743.357736] Starting subtest: lobf
[743.361985] Subtest lobf: SKIP (0.000s)
[743.428233] [104/133] (278s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[743.522815] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[743.526764] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[743.614971] [105/133] (278s left) gem_eio (in-flight-external)
[743.838261] Starting subtest: in-flight-external
[744.818813] Subtest in-flight-external: SUCCESS (0.982s)
[744.933132] [106/133] (277s left) syncobj_timeline (wait-any-interrupted)
[744.998840] Starting subtest: wait-any-interrupted
[745.101570] Subtest wait-any-interrupted: SUCCESS (0.103s)
[745.177001] [107/133] (277s left) syncobj_timeline (multi-wait-all-signaled)
[745.230042] Starting subtest: multi-wait-all-signaled
[745.232242] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[745.338188] [108/133] (277s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[745.429802] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[745.432032] Starting dynamic subtest: pipe-A-eDP-1
[745.490404] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[745.502637] Starting dynamic subtest: pipe-B-eDP-1
[745.558780] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[745.570524] Starting dynamic subtest: pipe-C-eDP-1
[745.627102] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[745.640381] Starting dynamic subtest: pipe-D-eDP-1
[745.695381] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[745.699502] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[747.753074] [109/133] (274s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[747.850490] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[747.854458] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[747.963786] [110/133] (274s left) syncobj_eventfd (binary-wait-before-signal)
[748.025454] Starting subtest: binary-wait-before-signal
[748.054426] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[748.143682] [111/133] (274s left) kms_flip (2x-plain-flip)
[748.239747] Starting subtest: 2x-plain-flip
[748.250504] Subtest 2x-plain-flip: SKIP (0.010s)
[748.330978] [112/133] (274s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[748.393742] Starting subtest: invalid-single-wait-unsubmitted
[748.396043] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[748.510691] [113/133] (274s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[748.587827] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[748.590042] Starting dynamic subtest: pipe-A-eDP-1
[748.612706] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[748.624986] Starting dynamic subtest: pipe-B-eDP-1
[748.646369] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[748.656455] Starting dynamic subtest: pipe-C-eDP-1
[748.677374] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[748.689611] Starting dynamic subtest: pipe-D-eDP-1
[748.708162] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[748.711500] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[750.921882] [114/133] (271s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[751.011561] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[751.015883] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[751.089810] [115/133] (271s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[751.192724] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[752.182450] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.990s)
[752.473446] [116/133] (270s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[752.772388] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[753.909197] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.138s)
[754.182207] [117/133] (268s left) prime_mmap (test_refcounting)
[754.246140] Starting subtest: test_refcounting
[754.248091] Starting dynamic subtest: test_refcounting-smem
[754.277040] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[754.279518] Subtest test_refcounting: SUCCESS (0.034s)
[754.370359] [118/133] (268s left) gen7_exec_parse (load-register-reg)
[754.438140] Subtest load-register-reg: SKIP (0.000s)
[754.507231] [119/133] (268s left) gem_exec_schedule (fairslice-all)
[754.583090] Starting subtest: fairslice-all
[756.638229] Subtest fairslice-all: SUCCESS (2.056s)
[756.959886] [120/133] (266s left) gem_ctx_engines (invalid-engines)
[757.028142] Starting subtest: invalid-engines
[757.043561] Subtest invalid-engines: SUCCESS (0.015s)
[757.280216] [121/133] (265s left) gem_ccs (block-copy-compressed)
[757.339647] Starting subtest: block-copy-compressed
[757.344004] Subtest block-copy-compressed: SKIP (0.000s)
[757.463888] [122/133] (265s left) kms_prime (d3hot)
[757.557546] Subtest D3hot: SKIP (0.000s)
[757.678382] [123/133] (265s left) gem_ppgtt (flink-and-close-vma-leak)
[757.739411] Starting subtest: flink-and-close-vma-leak
[757.781666] Subtest flink-and-close-vma-leak: SUCCESS (0.042s)
[757.916865] [124/133] (265s left) i915_pm_rpm (gem-execbuf)
[759.833783] Starting subtest: gem-execbuf
[759.836176] Starting dynamic subtest: smem0
[761.564106] Dynamic subtest smem0: SUCCESS (1.733s)
[761.566323] Subtest gem-execbuf: SUCCESS (1.734s)
[761.654786] [125/133] (261s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[761.767357] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[766.113603] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.347s)
[767.266897] [126/133] (256s left) gem_userptr_blits (input-checking)
[767.340900] Starting subtest: input-checking
[767.342831] Subtest input-checking: SUCCESS (0.000s)
[767.454924] [127/133] (255s left) kms_frontbuffer_tracking (psr-slowdraw)
[767.549753] Starting subtest: psr-slowdraw
[792.683107] Subtest psr-slowdraw: SUCCESS (25.136s)
[792.832585] [128/133] (230s left) gem_softpin (invalid)
[792.887818] Starting subtest: invalid
[792.896503] Subtest invalid: SUCCESS (0.007s)
[793.009065] [129/133] (230s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[793.105163] Starting subtest: fbcpsr-shrfb-scaledprimary
[798.906304] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.803s)
[799.043627] [130/133] (224s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[799.167141] Starting subtest: flip-vs-cursor-busy-crc-legacy
[799.975137] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.806s)
[800.786665] [131/133] (222s left) gem_linear_blits (normal)
[801.552487] Starting subtest: normal
[805.802422] Subtest normal: SUCCESS (4.249s)
[805.943489] [132/133] (217s left) kms_flip (flip-vs-panning-interruptible)
[806.093822] Starting subtest: flip-vs-panning-interruptible
[806.096159] Starting dynamic subtest: A-eDP1
[814.811040] Dynamic subtest A-eDP1: SUCCESS (8.716s)
[814.823921] Starting dynamic subtest: B-eDP1
[823.522373] Dynamic subtest B-eDP1: SUCCESS (8.710s)
[823.532732] Starting dynamic subtest: C-eDP1
[832.249825] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[832.261688] Starting dynamic subtest: D-eDP1
[840.971262] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[840.976242] Subtest flip-vs-panning-interruptible: SUCCESS (34.886s)
[842.129393] [133/133] (181s left) kms_prop_blob (invalid-get-prop)
[842.197453] Starting subtest: invalid-get-prop
[842.199563] Subtest invalid-get-prop: SUCCESS (0.000s)
[842.298021] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_async_flips
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_selftest
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_joiner
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_exec_flush
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: gem_mmap_wc
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_atomic_transition
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: kms_color_pipeline
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_lease
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_vrr
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: prime_mmap
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: kms_draw_crc
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: sysfs_defaults
results: parsing output: 47/ for test: kms_pm_backlight
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_mmap_offset
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_vm_create
results: parsing output: 55/ for test: gen3_render_linear_blits
results: parsing output: 56/ for test: drm_read
results: parsing output: 57/ for test: dmabuf_sync_file
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_getfb
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: gem_partial_pwrite_pread
results: parsing output: 65/ for test: api_intel_bb
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: prime_vgem
results: parsing output: 69/ for test: sriov_basic
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: syncobj_wait
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: gem_eio
results: parsing output: 76/ for test: gen9_exec_parse
results: parsing output: 77/ for test: gem_ctx_isolation
results: parsing output: 78/ for test: gem_exec_fence
results: parsing output: 79/ for test: kms_pm_dc
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_ctx_shared
results: parsing output: 83/ for test: kms_vblank
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: gem_exec_nop
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: gem_media_fill
results: parsing output: 92/ for test: kms_pipe_crc_basic
results: parsing output: 93/ for test: kms_plane_cursor
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: i915_hangman
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_create
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: kms_vrr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_eio
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_eventfd
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: prime_mmap
results: parsing output: 117/ for test: gen7_exec_parse
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: gem_ctx_engines
results: parsing output: 120/ for test: gem_ccs
results: parsing output: 121/ for test: kms_prime
results: parsing output: 122/ for test: gem_ppgtt
results: parsing output: 123/ for test: i915_pm_rpm
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_linear_blits
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_prop_blob
Done.