[56.805733] Initializing watchdogs
[56.805782]   /dev/watchdog0
[56.820791] [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]
[56.825667] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.828201] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.831627] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[57.129370] Starting subtest: cursor-offscreen-256x85
[57.184132] Subtest cursor-offscreen-256x85: SKIP (0.049s)
[57.346727] [002/133] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[57.443898] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[57.446175] Starting dynamic subtest: pipe-A-eDP-1
[57.504488] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[57.512081] Starting dynamic subtest: pipe-B-eDP-1
[57.568771] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[57.576973] Starting dynamic subtest: pipe-C-eDP-1
[57.627906] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[57.636050] Starting dynamic subtest: pipe-D-eDP-1
[57.684186] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[57.687898] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[59.681814] [003/133] (957s left) sysfs_timeslice_duration (duration)
[59.741136] Starting subtest: duration
[59.743489] Starting dynamic subtest: vecs0
[73.845572] Dynamic subtest vecs0: SUCCESS (14.133s)
[73.853923] Starting dynamic subtest: ccs0
[86.987886] Dynamic subtest ccs0: SUCCESS (13.144s)
[86.996939] Starting dynamic subtest: vcs0
[101.812833] Dynamic subtest vcs0: SUCCESS (14.822s)
[101.824853] Starting dynamic subtest: bcs0
[114.943934] Dynamic subtest bcs0: SUCCESS (13.131s)
[114.954677] Starting dynamic subtest: rcs0
[128.083279] Dynamic subtest rcs0: SUCCESS (13.138s)
[128.093097] Starting dynamic subtest: vcs1
[142.836950] Dynamic subtest vcs1: SUCCESS (14.751s)
[142.839777] Subtest duration: SUCCESS (83.126s)
[142.950963] [004/133] (874s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[143.062944] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[143.064927] Starting dynamic subtest: pipe-A-eDP-1
[161.853064] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.829s)
[161.862895] Starting dynamic subtest: pipe-B-eDP-1
[179.513199] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.429s)
[179.522639] Starting dynamic subtest: pipe-C-eDP-1
[196.477927] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.306s)
[196.490378] Starting dynamic subtest: pipe-D-eDP-1
[213.491447] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.377s)
[213.493875] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.945s)
[214.678720] [005/133] (802s left) drm_buddy (drm_buddy)
[214.714741] Starting subtest: drm_buddy
[214.719431] Subtest drm_buddy: SKIP (0.000s)
[214.764694] [006/133] (802s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[214.865428] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[215.647439] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.803s)
[215.815582] [007/133] (801s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[215.906472] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[215.908357] Starting dynamic subtest: pipe-A-eDP-1
[216.636064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[216.645622] Starting dynamic subtest: pipe-B-eDP-1
[218.447549] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.844s)
[218.455873] Starting dynamic subtest: pipe-C-eDP-1
[220.241141] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.819s)
[220.249214] Starting dynamic subtest: pipe-D-eDP-1
[222.049956] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.829s)
[222.052290] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.234s)
[223.170642] [008/133] (794s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[223.261949] Starting subtest: bad-pixel-format-yf-tiled-ccs
[223.264377] Starting dynamic subtest: pipe-A-eDP-1
[223.294421] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[223.304497] Starting dynamic subtest: pipe-B-eDP-1
[223.325941] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[223.333851] Starting dynamic subtest: pipe-C-eDP-1
[223.354073] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[223.361611] Starting dynamic subtest: pipe-D-eDP-1
[223.384413] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[223.388474] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[225.518514] [009/133] (792s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[225.574570] Starting subtest: multi-wait-available-unsubmitted-submitted
[225.576769] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[225.668486] [010/133] (792s left) perf_pmu (event-wait)
[225.713494] Starting subtest: event-wait
[225.715942] Starting dynamic subtest: rcs0
[225.720075] Dynamic subtest rcs0: SKIP (0.000s)
[225.723931] Subtest event-wait: SKIP (0.000s)
[225.818120] [011/133] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[225.906993] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[225.911237] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[226.009726] [012/133] (791s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[226.112867] Starting subtest: psr-rgb565-draw-mmap-gtt
[226.116932] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[226.201944] [013/133] (791s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[226.308641] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[226.311021] Starting dynamic subtest: pipe-A-eDP-1
[232.169080] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.891s)
[232.185344] Starting dynamic subtest: pipe-B-eDP-1
[238.817353] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.659s)
[238.819654] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.553s)
[239.695275] [014/133] (778s left) kms_psr (fbc-psr2-dpms)
[239.795546] Starting subtest: fbc-psr2-dpms
[239.797702] Starting dynamic subtest: eDP-1
[239.801636] Dynamic subtest eDP-1: SKIP (0.000s)
[239.806552] Subtest fbc-psr2-dpms: SKIP (0.001s)
[239.866778] [015/133] (778s left) gem_exec_balancer (parallel-ordering)
[240.119751] Starting subtest: parallel-ordering
[241.098719] Subtest parallel-ordering: SUCCESS (0.980s)
[241.216727] [016/133] (776s left) kms_joiner (basic-big-joiner)
[241.315435] Starting subtest: basic-big-joiner
[241.319663] Subtest basic-big-joiner: SKIP (0.000s)
[241.382936] [017/133] (776s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[241.506947] Starting subtest: flip-vs-cursor-crc-atomic
[242.198102] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.691s)
[243.021576] [018/133] (775s left) gem_wait (wait)
[243.093632] Starting subtest: wait
[243.095819] Starting dynamic subtest: all-engines
[244.401700] Dynamic subtest all-engines: SUCCESS (1.308s)
[244.413412] Starting dynamic subtest: rcs0
[245.444676] Dynamic subtest rcs0: SUCCESS (1.043s)
[245.455373] Starting dynamic subtest: bcs0
[246.489240] Dynamic subtest bcs0: SUCCESS (1.043s)
[246.500307] Starting dynamic subtest: vcs0
[247.533317] Dynamic subtest vcs0: SUCCESS (1.042s)
[247.544173] Starting dynamic subtest: vcs1
[248.579837] Dynamic subtest vcs1: SUCCESS (1.043s)
[248.591689] Starting dynamic subtest: vecs0
[249.624452] Dynamic subtest vecs0: SUCCESS (1.042s)
[249.635548] Starting dynamic subtest: ccs0
[250.669436] Dynamic subtest ccs0: SUCCESS (1.045s)
[250.672066] Subtest wait: SUCCESS (7.576s)
[250.871049] [019/133] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[250.979835] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[250.983983] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[251.080581] [020/133] (767s left) kms_flip (2x-flip-vs-expired-vblank)
[251.171907] Starting subtest: 2x-flip-vs-expired-vblank
[251.181502] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[251.260090] [021/133] (766s left) kms_lease (page-flip-implicit-plane)
[251.345154] Starting subtest: page-flip-implicit-plane
[251.347483] Starting dynamic subtest: pipe-A-eDP-1
[251.835195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.486s)
[251.845561] Starting dynamic subtest: pipe-B-eDP-1
[252.967364] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.132s)
[252.977297] Starting dynamic subtest: pipe-C-eDP-1
[254.074904] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[254.084666] Starting dynamic subtest: pipe-D-eDP-1
[255.209736] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[255.212102] Subtest page-flip-implicit-plane: SUCCESS (3.862s)
[256.047309] [022/133] (762s left) gem_exec_params (rsvd2-dirt)
[256.111081] Starting subtest: rsvd2-dirt
[256.115515] Subtest rsvd2-dirt: SKIP (0.000s)
[256.209083] [023/133] (762s left) api_intel_bb (blit-reloc-purge-cache)
[256.274870] Starting subtest: blit-reloc-purge-cache
[256.279333] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[256.391653] [024/133] (761s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[256.490409] Starting subtest: fbc-shrfb-scaledprimary
[259.426905] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.941s)
[260.552873] [025/133] (757s left) i915_pm_rpm (gem-idle)
[262.584338] Starting subtest: gem-idle
[268.780907] Subtest gem-idle: SUCCESS (6.202s)
[269.107550] [026/133] (749s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[270.338312] Starting subtest: x-tiled-8bpp-rotate-0
[271.561096] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.224s)
[271.683138] [027/133] (746s left) gem_exec_schedule (preempt-contexts)
[271.757061] Starting subtest: preempt-contexts
[271.758783] Starting dynamic subtest: rcs0
[271.805421] Dynamic subtest rcs0: SUCCESS (0.054s)
[271.814720] Starting dynamic subtest: bcs0
[271.864104] Dynamic subtest bcs0: SUCCESS (0.058s)
[271.876373] Starting dynamic subtest: vcs0
[271.919632] Dynamic subtest vcs0: SUCCESS (0.055s)
[271.928517] Starting dynamic subtest: vcs1
[271.965424] Dynamic subtest vcs1: SUCCESS (0.045s)
[271.974468] Starting dynamic subtest: vecs0
[272.009583] Dynamic subtest vecs0: SUCCESS (0.044s)
[272.018040] Starting dynamic subtest: ccs0
[272.061599] Dynamic subtest ccs0: SUCCESS (0.051s)
[272.063403] Subtest preempt-contexts: SUCCESS (0.311s)
[273.412194] [028/133] (745s left) gem_exec_flush (basic-uc-rw-default)
[273.474374] Starting subtest: basic-uc-rw-default
[278.928451] Subtest basic-uc-rw-default: SUCCESS (5.457s)
[279.127171] [029/133] (739s left) kms_color_pipeline (plane-lut1d)
[279.223925] Starting subtest: plane-lut1d
[279.369323] Starting dynamic subtest: pipe-A-plane-0
[279.724459] Dynamic subtest pipe-A-plane-0: FAIL (0.186s)
[279.733788] Starting dynamic subtest: pipe-A-plane-1
[279.942388] Dynamic subtest pipe-A-plane-1: FAIL (0.165s)
[279.951097] Starting dynamic subtest: pipe-A-plane-2
[280.178207] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[281.093582] Starting dynamic subtest: pipe-B-plane-0
[281.553778] Dynamic subtest pipe-B-plane-0: FAIL (0.196s)
[281.569527] Starting dynamic subtest: pipe-B-plane-1
[281.880514] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[281.891420] Starting dynamic subtest: pipe-B-plane-2
[282.183580] Dynamic subtest pipe-B-plane-2: FAIL (0.182s)
[282.837573] Starting dynamic subtest: pipe-C-plane-0
[283.321592] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[283.333105] Starting dynamic subtest: pipe-C-plane-1
[283.716406] Dynamic subtest pipe-C-plane-1: FAIL (0.133s)
[283.726157] Starting dynamic subtest: pipe-C-plane-2
[284.068128] Dynamic subtest pipe-C-plane-2: FAIL (0.642s)
[284.940272] Starting dynamic subtest: pipe-D-plane-0
[285.499699] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[285.509043] Starting dynamic subtest: pipe-D-plane-1
[285.938205] Dynamic subtest pipe-D-plane-1: FAIL (0.587s)
[285.947306] Starting dynamic subtest: pipe-D-plane-2
[286.341535] Dynamic subtest pipe-D-plane-2: FAIL (0.521s)
[286.478591] Subtest plane-lut1d: FAIL (7.258s)
[287.325414] [030/133] (731s left) gem_exec_schedule (deep)
[287.520467] Starting subtest: deep
[287.523030] Starting dynamic subtest: rcs0
[292.710643] Dynamic subtest rcs0: SKIP (5.187s)
[292.730046] Starting dynamic subtest: vcs0
[302.887868] Dynamic subtest vcs0: SUCCESS (10.183s)
[302.899937] Starting dynamic subtest: vcs1
[314.725186] Dynamic subtest vcs1: SUCCESS (11.835s)
[314.738292] Starting dynamic subtest: vecs0
[326.463787] Dynamic subtest vecs0: SUCCESS (11.734s)
[326.475062] Starting dynamic subtest: ccs0
[338.062729] Dynamic subtest ccs0: SUCCESS (11.595s)
[338.066947] Subtest deep: SUCCESS (50.540s)
[339.172608] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[339.176322] [031/133] (679s left) kms_cursor_crc (cursor-suspend)
[339.306909] Starting subtest: cursor-suspend
[339.309138] Starting dynamic subtest: pipe-A-eDP-1
[372.794985] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.144s)
[372.804144] Starting dynamic subtest: pipe-D-eDP-1
[406.765019] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.795s)
[406.767786] Subtest cursor-suspend: SUCCESS (6.941s)
[407.584876] [032/133] (611s left) perf (gen8-unprivileged-single-ctx-counters)
[407.734548] Starting subtest: gen8-unprivileged-single-ctx-counters
[407.739258] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[407.777938] [033/133] (610s left) api_intel_bb (intel-bb-blit-y)
[407.831418] Starting subtest: intel-bb-blit-y
[411.528139] Subtest intel-bb-blit-y: SUCCESS (3.769s)
[411.648095] [034/133] (607s left) prime_mmap (test_refcounting)
[411.707684] Starting subtest: test_refcounting
[411.709683] Starting dynamic subtest: test_refcounting-smem
[411.738740] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[411.741685] Subtest test_refcounting: SUCCESS (0.033s)
[411.857007] [035/133] (606s left) kms_atomic_transition (modeset-transition)
[411.948365] Starting subtest: modeset-transition
[411.950528] Starting dynamic subtest: 1x-outputs
[422.883862] Dynamic subtest 1x-outputs: SUCCESS (11.022s)
[422.886652] Subtest modeset-transition: SUCCESS (11.023s)
[423.736035] [036/133] (595s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[423.824554] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[423.827154] Starting dynamic subtest: pipe-A
[423.844126] Dynamic subtest pipe-A: SKIP (0.016s)
[423.854489] Starting dynamic subtest: pipe-B
[423.874484] Dynamic subtest pipe-B: SKIP (0.028s)
[423.883699] Starting dynamic subtest: pipe-C
[423.902055] Dynamic subtest pipe-C: SKIP (0.028s)
[423.910821] Starting dynamic subtest: pipe-D
[423.930442] Dynamic subtest pipe-D: SKIP (0.029s)
[423.934377] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.104s)
[424.023950] [037/133] (594s left) kms_frontbuffer_tracking (fbc-suspend)
[424.120576] Starting subtest: fbc-suspend
[462.737386] Subtest fbc-suspend: SUCCESS (7.496s)
[463.908520] [038/133] (554s left) gem_pxp (display-protected-crc)
[464.032126] Starting subtest: display-protected-crc
[465.769917] Subtest display-protected-crc: SUCCESS (1.768s)
[465.878020] [039/133] (553s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[465.983652] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[465.988819] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[466.080198] [040/133] (552s left) gem_userptr_blits (dmabuf-unsync)
[466.145556] Subtest dmabuf-unsync: SKIP (0.000s)
[466.258020] [041/133] (552s left) gem_eio (context-create)
[466.497582] Starting subtest: context-create
[466.826358] Subtest context-create: SUCCESS (0.336s)
[466.941345] [042/133] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[467.042091] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[473.784540] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.799s)
[473.963650] [043/133] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[474.068808] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[474.073812] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[474.170203] [044/133] (544s left) kms_selftest (drm_dp_mst_helper)
[474.209874] Starting subtest: drm_dp_mst_helper
[474.281628] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[474.391167] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.108s)
[474.402281] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[474.482167] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.093s)
[474.492213] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[474.605473] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.122s)
[474.607981] Subtest drm_dp_mst_helper: SUCCESS (0.396s)
[474.770114] [045/133] (544s left) gem_spin_batch (resubmit-new)
[474.832666] Starting subtest: resubmit-new
[474.834946] Starting dynamic subtest: rcs0
[474.843652] Dynamic subtest rcs0: SUCCESS (0.011s)
[474.856036] Starting dynamic subtest: bcs0
[474.858821] Dynamic subtest bcs0: SUCCESS (0.005s)
[474.867967] Starting dynamic subtest: vcs0
[474.869876] Dynamic subtest vcs0: SUCCESS (0.004s)
[474.879468] Starting dynamic subtest: vcs1
[474.881400] Dynamic subtest vcs1: SUCCESS (0.004s)
[474.890392] Starting dynamic subtest: vecs0
[474.892177] Dynamic subtest vecs0: SUCCESS (0.004s)
[474.901169] Starting dynamic subtest: ccs0
[474.903185] Dynamic subtest ccs0: SUCCESS (0.007s)
[474.905344] Subtest resubmit-new: SUCCESS (0.040s)
[476.239811] [046/133] (542s left) testdisplay
[476.571606] [047/133] (542s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[476.666907] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[476.669488] Starting dynamic subtest: pipe-A-eDP-1
[476.781247] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[476.791750] Starting dynamic subtest: pipe-B-eDP-1
[477.979862] Dynamic subtest pipe-B-eDP-1: SKIP (1.200s)
[477.984542] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.325s)
[479.170076] [048/133] (540s left) i915_selftest (live)
[482.455978] Starting subtest: live
[482.458674] Starting dynamic subtest: sanitycheck
[485.985426] Dynamic subtest sanitycheck: SUCCESS (3.535s)
[485.995391] Starting dynamic subtest: uncore
[491.663709] Dynamic subtest uncore: SUCCESS (5.681s)
[491.674055] Starting dynamic subtest: workarounds
[495.579575] Dynamic subtest workarounds: SUCCESS (3.910s)
[495.589699] Starting dynamic subtest: gt_engines
[501.015205] Dynamic subtest gt_engines: SUCCESS (5.431s)
[501.030379] Starting dynamic subtest: gt_timelines
[517.674195] Dynamic subtest gt_timelines: SUCCESS (16.655s)
[517.684308] Starting dynamic subtest: gt_contexts
[521.355772] Dynamic subtest gt_contexts: SUCCESS (3.679s)
[521.365161] Starting dynamic subtest: gt_lrc
[526.527174] Dynamic subtest gt_lrc: SUCCESS (5.170s)
[526.537203] Starting dynamic subtest: gt_mocs
[530.326915] Dynamic subtest gt_mocs: SUCCESS (3.799s)
[530.336206] Starting dynamic subtest: gt_pm
[537.947385] Dynamic subtest gt_pm: SUCCESS (7.621s)
[537.962757] Starting dynamic subtest: gt_heartbeat
[541.494052] Dynamic subtest gt_heartbeat: SUCCESS (3.546s)
[541.502426] Starting dynamic subtest: gt_tlb
[551.763931] Dynamic subtest gt_tlb: SUCCESS (10.270s)
[551.773847] Starting dynamic subtest: requests
[564.075635] Dynamic subtest requests: SUCCESS (12.308s)
[564.085683] Starting dynamic subtest: migrate
[570.612780] Dynamic subtest migrate: SUCCESS (6.535s)
[570.623206] Starting dynamic subtest: active
[575.749725] Dynamic subtest active: SUCCESS (5.134s)
[575.758353] Starting dynamic subtest: objects
[579.938382] Dynamic subtest objects: SUCCESS (4.185s)
[579.948404] Starting dynamic subtest: mman
[585.633973] Dynamic subtest mman: SUCCESS (5.694s)
[585.644559] Starting dynamic subtest: dmabuf
[589.199314] Dynamic subtest dmabuf: SUCCESS (3.563s)
[589.208690] Starting dynamic subtest: vma
[592.749584] Dynamic subtest vma: SUCCESS (3.550s)
[592.760126] Starting dynamic subtest: coherency
[597.595690] Dynamic subtest coherency: SUCCESS (4.845s)
[597.606083] Starting dynamic subtest: gtt
[608.189842] Dynamic subtest gtt: SUCCESS (10.594s)
[608.200149] Starting dynamic subtest: gem
[615.375017] Dynamic subtest gem: SUCCESS (7.184s)
[615.396299] Starting dynamic subtest: evict
[621.830744] Dynamic subtest evict: SUCCESS (6.453s)
[621.841056] Starting dynamic subtest: hugepages
[631.526486] Dynamic subtest hugepages: SUCCESS (9.695s)
[631.536877] Starting dynamic subtest: gem_contexts
[659.205777] Dynamic subtest gem_contexts: SUCCESS (27.684s)
[659.216906] Starting dynamic subtest: client
[662.788378] Dynamic subtest client: SUCCESS (3.582s)
[662.798595] Starting dynamic subtest: gem_migrate
[666.337192] Dynamic subtest gem_migrate: SUCCESS (3.548s)
[666.345421] Starting dynamic subtest: reset
[671.494459] Dynamic subtest reset: SUCCESS (5.156s)
[671.509781] Starting dynamic subtest: memory_region
[675.101563] Dynamic subtest memory_region: SUCCESS (3.606s)
[675.111970] Starting dynamic subtest: hangcheck
[688.848079] Dynamic subtest hangcheck: SUCCESS (13.746s)
[688.860844] Starting dynamic subtest: execlists
[694.007202] Dynamic subtest execlists: SUCCESS (5.156s)
[694.017475] Starting dynamic subtest: ring_submission
[697.514943] Dynamic subtest ring_submission: SUCCESS (3.505s)
[697.525109] Starting dynamic subtest: perf
[701.199474] Dynamic subtest perf: SUCCESS (3.682s)
[701.209217] Starting dynamic subtest: slpc
[714.189518] Dynamic subtest slpc: SUCCESS (12.986s)
[714.198657] Starting dynamic subtest: guc
[718.947601] Dynamic subtest guc: SUCCESS (4.755s)
[718.957008] Starting dynamic subtest: guc_multi_lrc
[722.505126] Dynamic subtest guc_multi_lrc: SUCCESS (3.555s)
[722.514031] Starting dynamic subtest: guc_hang
[726.823193] Dynamic subtest guc_hang: SUCCESS (4.316s)
[726.833105] Starting dynamic subtest: late_gt_pm
[730.394963] Dynamic subtest late_gt_pm: SUCCESS (3.570s)
[730.398006] Subtest live: SUCCESS (247.951s)
[730.428447] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[730.429198] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[730.432676] [049/133] (288s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[732.850480] Subtest writes-after-reads-uncached: SKIP (0.000s)
[732.921988] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[732.924265] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true
[732.928479] [050/133] (286s left) kms_getfb (getfb-handle-not-fb)
[733.022202] Starting subtest: getfb-handle-not-fb
[733.024636] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[733.119530] [051/133] (286s left) kms_psr (fbc-psr-sprite-plane-onoff)
[733.211897] Starting subtest: fbc-psr-sprite-plane-onoff
[733.214831] Starting dynamic subtest: eDP-1
[733.220100] Dynamic subtest eDP-1: SKIP (0.000s)
[733.225582] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[733.290181] [052/133] (286s left) i915_hangman (gt-error-state-capture)
[733.360009] Starting subtest: gt-error-state-capture
[733.362783] Starting dynamic subtest: rcs0
[745.223111] Dynamic subtest rcs0: SUCCESS (11.861s)
[745.236226] Starting dynamic subtest: bcs0
[757.192273] Dynamic subtest bcs0: SUCCESS (11.966s)
[757.204371] Starting dynamic subtest: vcs0
[769.159887] Dynamic subtest vcs0: SUCCESS (11.966s)
[769.171290] Starting dynamic subtest: vcs1
[781.125215] Dynamic subtest vcs1: SUCCESS (11.964s)
[781.137203] Starting dynamic subtest: vecs0
[791.109363] Dynamic subtest vecs0: SUCCESS (9.982s)
[791.122631] Starting dynamic subtest: ccs0
[802.182034] Dynamic subtest ccs0: SUCCESS (11.070s)
[802.185064] Subtest gt-error-state-capture: SUCCESS (68.823s)
[802.269982] [053/133] (217s left) perf (invalid-open-flags)
[802.386029] Starting subtest: invalid-open-flags
[802.388448] Subtest invalid-open-flags: SUCCESS (0.000s)
[802.432587] [054/133] (217s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[802.531012] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[802.536179] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[802.623569] [055/133] (216s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[802.712223] Starting subtest: async-flip-with-page-flip-events-linear
[803.105054] Starting dynamic subtest: pipe-A-eDP-1
[805.865104] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.760s)
[806.230679] Starting dynamic subtest: pipe-B-eDP-1
[808.992358] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.772s)
[809.355739] Starting dynamic subtest: pipe-C-eDP-1
[812.120761] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.773s)
[812.497022] Starting dynamic subtest: pipe-D-eDP-1
[815.249041] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s)
[815.251619] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.541s)
[816.436947] [056/133] (203s left) sw_sync (alloc_fence)
[816.483053] Starting subtest: alloc_fence
[816.486057] Subtest alloc_fence: SUCCESS (0.000s)
[816.538116] [057/133] (203s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[816.632976] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[816.635629] Starting dynamic subtest: pipe-A-default-mode
[817.803959] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[817.808997] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.170s)
[817.947036] [058/133] (201s left) gem_ctx_persistence (heartbeat-close)
[818.012110] Starting subtest: heartbeat-close
[818.018072] Subtest heartbeat-close: SKIP (0.001s)
[818.121530] [059/133] (201s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[818.221712] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[818.226934] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[818.324652] [060/133] (201s left) kms_flip (2x-flip-vs-modeset)
[818.418953] Starting subtest: 2x-flip-vs-modeset
[818.429188] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[818.517069] [061/133] (201s left) sw_sync (alloc_timeline)
[818.556115] Starting subtest: alloc_timeline
[818.559032] Subtest alloc_timeline: SUCCESS (0.000s)
[818.611675] [062/133] (201s left) gem_exec_fence (syncobj-timeline-chain-engines)
[819.144726] Starting subtest: syncobj-timeline-chain-engines
[819.276456] Subtest syncobj-timeline-chain-engines: SUCCESS (0.132s)
[820.291322] [063/133] (199s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[820.384015] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[820.389066] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[820.457189] [064/133] (199s left) perf_pmu (all-busy-check-all)
[820.496047] Starting subtest: all-busy-check-all
[822.256261] Subtest all-busy-check-all: SUCCESS (1.752s)
[822.342689] [065/133] (197s left) kms_chamelium_frames (hdmi-crc-single)
[822.736672] Subtest hdmi-crc-single: SKIP (0.000s)
[823.585938] [066/133] (196s left) kms_draw_crc (draw-method-mmap-wc)
[823.683868] Starting subtest: draw-method-mmap-wc
[823.686009] Starting dynamic subtest: xrgb8888-untiled
[823.905773] Dynamic subtest xrgb8888-untiled: SUCCESS (0.224s)
[823.915552] Starting dynamic subtest: rgb565-untiled
[824.117846] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[824.127353] Starting dynamic subtest: xrgb2101010-untiled
[824.316933] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[824.326971] Starting dynamic subtest: xbgr16161616f-untiled
[824.538492] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[824.547950] Starting dynamic subtest: xrgb8888-xtiled
[824.660584] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[824.669671] Starting dynamic subtest: rgb565-xtiled
[824.782977] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[824.792336] Starting dynamic subtest: xrgb2101010-xtiled
[824.905395] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[824.914933] Starting dynamic subtest: xbgr16161616f-xtiled
[825.027833] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[825.037447] Starting dynamic subtest: xrgb8888-4tiled
[825.183188] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[825.193816] Starting dynamic subtest: rgb565-4tiled
[825.338794] Dynamic subtest rgb565-4tiled: SUCCESS (0.154s)
[825.348512] Starting dynamic subtest: xrgb2101010-4tiled
[825.494068] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s)
[825.504197] Starting dynamic subtest: xbgr16161616f-4tiled
[825.671767] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.175s)
[825.673983] Subtest draw-method-mmap-wc: SUCCESS (1.991s)
[825.766391] [067/133] (194s left) kms_content_protection (atomic)
[825.904041] Starting subtest: atomic
[825.908879] Subtest atomic: SKIP (0.000s)
[826.032091] [068/133] (194s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[826.121608] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[826.123873] Starting dynamic subtest: pipe-A-eDP-1
[826.146180] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[826.157098] Starting dynamic subtest: pipe-B-eDP-1
[826.179951] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[826.189005] Starting dynamic subtest: pipe-C-eDP-1
[826.211124] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[826.220038] Starting dynamic subtest: pipe-D-eDP-1
[826.243084] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[826.247773] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[828.282068] [069/133] (191s left) kms_psr (pr-primary-render)
[828.380283] Starting subtest: pr-primary-render
[828.385952] Subtest pr-primary-render: SKIP (0.000s)
[828.459074] [070/133] (191s left) gem_exec_flush (basic-uc-ro-default)
[828.530795] Starting subtest: basic-uc-ro-default
[833.996060] Subtest basic-uc-ro-default: SUCCESS (5.468s)
[834.189978] [071/133] (186s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[834.277129] Starting subtest: fb-8bpc-vs-panel-8bpc
[834.279585] Starting dynamic subtest: pipe-A-eDP-1
[835.679846] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.404s)
[835.682488] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.405s)
[836.547521] [072/133] (183s left) gem_madvise (dontneed-after-mmap)
[836.589734] Starting subtest: dontneed-after-mmap
[836.605469] Subtest dontneed-after-mmap: SUCCESS (0.018s)
[836.726649] [073/133] (183s left) kms_plane_alpha_blend (constant-alpha-mid)
[836.826609] Starting subtest: constant-alpha-mid
[837.118743] Starting dynamic subtest: pipe-A-eDP-1
[838.029308] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.910s)
[838.039198] Starting dynamic subtest: pipe-D-eDP-1
[839.626895] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.595s)
[839.629773] Subtest constant-alpha-mid: SUCCESS (2.802s)
[840.426415] [074/133] (179s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[840.496940] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[840.554589] [075/133] (179s left) kms_flip (2x-flip-vs-wf_vblank)
[840.655043] Starting subtest: 2x-flip-vs-wf_vblank
[840.671687] Subtest 2x-flip-vs-wf_vblank: SKIP (0.017s)
[840.751455] [076/133] (179s left) kms_cursor_crc (cursor-sliding-128x42)
[840.980040] Starting subtest: cursor-sliding-128x42
[841.027038] Subtest cursor-sliding-128x42: SKIP (0.042s)
[841.225722] [077/133] (179s left) kms_psr (psr2-suspend)
[841.317950] Starting subtest: psr2-suspend
[841.320760] Starting dynamic subtest: eDP-1
[858.746687] Dynamic subtest eDP-1: SUCCESS (2.852s)
[858.749312] Subtest psr2-suspend: SUCCESS (2.853s)
[859.699964] [078/133] (160s left) gem_mmap_offset (open-flood)
[859.857275] Starting subtest: open-flood
[881.395808] Subtest open-flood: SUCCESS (21.492s)
[881.497208] [079/133] (139s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[881.593135] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[881.597815] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[881.713293] [080/133] (139s left) gem_exec_nop (basic-sequential)
[881.782400] Starting subtest: basic-sequential
[896.269402] Subtest basic-sequential: SUCCESS (14.492s)
[896.501606] [081/133] (124s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[896.615248] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[896.620164] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[896.688408] [082/133] (124s left) gem_mmap_gtt (basic-small-bo-tiledy)
[896.743857] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[896.806372] [083/133] (124s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[896.904066] Starting subtest: y-tiled-64bpp-rotate-90
[896.908817] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[897.004657] [084/133] (123s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[897.100281] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[905.802370] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.708s)
[905.914804] [085/133] (115s left) gem_exec_alignment (single)
[905.968927] Starting subtest: single
[905.974293] Subtest single: SUCCESS (0.005s)
[906.095703] [086/133] (114s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[906.196037] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[906.201324] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[906.286588] [087/133] (114s left) syncobj_timeline (etime-single-wait-submitted)
[906.335190] Starting subtest: etime-single-wait-submitted
[906.444736] Subtest etime-single-wait-submitted: SUCCESS (0.109s)
[906.523609] [088/133] (114s left) i915_drm_fdinfo (virtual-busy-all)
[906.565213] Starting subtest: virtual-busy-all
[906.570661] Subtest virtual-busy-all: SKIP (0.000s)
[906.649680] [089/133] (114s left) gem_ctx_exec (basic)
[906.711322] Starting subtest: basic
[906.717265] Subtest basic: SUCCESS (0.007s)
[906.844206] [090/133] (114s left) gem_busy (parallel)
[907.024134] Starting subtest: parallel
[907.027043] Starting dynamic subtest: rcs0
[908.824151] Dynamic subtest rcs0: SUCCESS (1.799s)
[908.837284] Starting dynamic subtest: bcs0
[910.809287] Dynamic subtest bcs0: SUCCESS (1.981s)
[910.822277] Starting dynamic subtest: vcs0
[912.793199] Dynamic subtest vcs0: SUCCESS (1.981s)
[912.805966] Starting dynamic subtest: vcs1
[914.776811] Dynamic subtest vcs1: SUCCESS (1.981s)
[914.789386] Starting dynamic subtest: vecs0
[916.824166] Dynamic subtest vecs0: SUCCESS (2.044s)
[916.836985] Starting dynamic subtest: ccs0
[918.808705] Dynamic subtest ccs0: SUCCESS (1.982s)
[918.811545] Subtest parallel: SUCCESS (11.785s)
[919.037769] [091/133] (102s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[919.100233] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[919.103258] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[919.197119] [092/133] (102s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[919.302421] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[919.307952] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[919.371443] [093/133] (101s left) kms_vblank (ts-continuation-dpms-rpm)
[919.474227] Starting subtest: ts-continuation-dpms-rpm
[919.476635] Starting dynamic subtest: pipe-A-eDP-1
[922.018386] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.545s)
[922.034186] Starting dynamic subtest: pipe-D-eDP-1
[924.261819] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.242s)
[924.264408] Subtest ts-continuation-dpms-rpm: SUCCESS (4.790s)
[925.063747] [094/133] ( 96s left) sw_sync (timeline_closed_signaled)
[925.096860] Starting subtest: timeline_closed_signaled
[925.099376] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[925.154287] [095/133] ( 96s left) gem_lmem_swapping (verify)
[925.199897] Subtest verify: SKIP (0.000s)
[925.249893] [096/133] ( 96s left) syncobj_wait (invalid-signal-zero-handles)
[925.308674] Starting subtest: invalid-signal-zero-handles
[925.311242] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[925.412006] [097/133] ( 96s left) kms_pm_rpm (i2c)
[926.935335] Starting subtest: i2c
[932.375210] Subtest i2c: SUCCESS (5.441s)
[932.481124] [098/133] ( 89s left) vgem_basic (setversion)
[932.528254] Starting subtest: setversion
[932.533484] Subtest setversion: SUCCESS (0.000s)
[932.585632] [099/133] ( 88s left) gem_exec_reloc (basic-write-gtt)
[932.651500] Subtest basic-write-gtt: SKIP (0.000s)
[932.716916] [100/133] ( 88s left) kms_scaling_modes (scaling-mode-center)
[932.808255] Starting subtest: scaling-mode-center
[932.811069] Starting dynamic subtest: pipe-A-eDP-1
[932.905670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.099s)
[932.917680] Starting dynamic subtest: pipe-B-eDP-1
[934.074014] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s)
[934.084750] Starting dynamic subtest: pipe-C-eDP-1
[935.193074] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.118s)
[935.203327] Starting dynamic subtest: pipe-D-eDP-1
[936.320361] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[936.323169] Subtest scaling-mode-center: SUCCESS (3.514s)
[937.488112] [101/133] ( 84s left) perf_pmu (frequency)
[937.536926] Starting subtest: frequency
[937.543615] Starting dynamic subtest: gt0
[939.675542] Dynamic subtest gt0: SUCCESS (2.129s)
[939.687659] Starting dynamic subtest: idle-gt0
[940.179693] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[940.195065] Starting dynamic subtest: gt1
[944.772088] Dynamic subtest gt1: SUCCESS (4.585s)
[944.783380] Starting dynamic subtest: idle-gt1
[945.295036] Dynamic subtest idle-gt1: SUCCESS (0.523s)
[945.297846] Subtest frequency: SUCCESS (7.758s)
[945.387790] [102/133] ( 76s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[945.492112] Starting subtest: 4-tiled-32bpp-rotate-180
[946.869995] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.380s)
[946.995949] [103/133] ( 74s left) kms_hdr (bpc-switch-dpms)
[947.085161] Starting subtest: bpc-switch-dpms
[948.165164] Starting dynamic subtest: pipe-A-eDP-1
[952.683322] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.519s)
[952.686217] Subtest bpc-switch-dpms: SUCCESS (5.597s)
[952.786701] [104/133] ( 69s left) syncobj_timeline (wait-any-interrupted)
[952.842145] Starting subtest: wait-any-interrupted
[952.945100] Subtest wait-any-interrupted: SUCCESS (0.103s)
[953.021609] [105/133] ( 68s left) gem_exec_parallel (contexts)
[953.070330] Starting subtest: contexts
[953.073089] Starting dynamic subtest: rcs0
[956.356679] Dynamic subtest rcs0: SUCCESS (3.284s)
[956.368025] Starting dynamic subtest: bcs0
[960.421232] Dynamic subtest bcs0: SUCCESS (4.063s)
[960.432213] Starting dynamic subtest: vcs0
[966.105398] Dynamic subtest vcs0: SUCCESS (5.684s)
[966.117306] Starting dynamic subtest: vcs1
[972.134978] Dynamic subtest vcs1: SUCCESS (6.028s)
[972.146401] Starting dynamic subtest: vecs0
[978.155414] Dynamic subtest vecs0: SUCCESS (6.020s)
[978.169669] Starting dynamic subtest: ccs0
[982.923421] Dynamic subtest ccs0: SUCCESS (4.766s)
[982.926379] Subtest contexts: SUCCESS (29.857s)
[983.127834] [106/133] ( 38s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[983.247720] Starting subtest: verify-pxp-key-change-after-suspend-resume
[991.181586] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.937s)
[991.311100] [107/133] ( 30s left) gem_create (create-ext-placement-each)
[991.473557] Starting subtest: create-ext-placement-each
[991.476424] Subtest create-ext-placement-each: SUCCESS (0.000s)
[991.563901] [108/133] ( 30s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[991.663073] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[991.665441] Starting dynamic subtest: pipe-A-eDP-1
[991.689188] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[991.701378] Starting dynamic subtest: pipe-B-eDP-1
[991.724397] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[991.734393] Starting dynamic subtest: pipe-C-eDP-1
[991.757586] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[991.768434] Starting dynamic subtest: pipe-D-eDP-1
[991.791235] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[991.793630] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[993.847169] [109/133] ( 28s left) gem_close_race (basic-process)
[993.906383] Starting subtest: basic-process
[993.982920] Subtest basic-process: SUCCESS (0.077s)
[994.188535] [110/133] ( 27s left) gem_exec_schedule (u-independent)
[994.277982] Starting subtest: u-independent
[994.280104] Starting dynamic subtest: rcs0
[995.803230] Dynamic subtest rcs0: SUCCESS (1.534s)
[995.816273] Starting dynamic subtest: vcs0
[997.795457] Dynamic subtest vcs0: SUCCESS (1.989s)
[997.810604] Starting dynamic subtest: vcs1
[999.778335] Dynamic subtest vcs1: SUCCESS (1.980s)
[999.791187] Starting dynamic subtest: vecs0
[1001.833977] Dynamic subtest vecs0: SUCCESS (2.053s)
[1001.847422] Starting dynamic subtest: ccs0
[1003.800539] Dynamic subtest ccs0: SUCCESS (1.965s)
[1003.803403] Subtest u-independent: SUCCESS (9.533s)
[1004.112498] [111/133] ( 18s left) gen9_exec_parse (batch-without-end)
[1004.174324] Subtest batch-without-end: SKIP (0.000s)
[1004.236162] [112/133] ( 17s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[1005.966805] Starting subtest: dpms-mode-unset-lpsp
[1010.038304] Subtest dpms-mode-unset-lpsp: SUCCESS (4.070s)
[1010.422839] [113/133] ( 11s left) kms_chamelium_hpd (vga-hpd)
[1010.824916] Subtest vga-hpd: SKIP (0.000s)
[1011.618601] [114/133] ( 10s left) gem_lmem_swapping (heavy-multi)
[1011.664199] Subtest heavy-multi: SKIP (0.000s)
[1011.710435] [115/133] ( 10s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[1011.805717] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[1011.810251] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[1011.876636] [116/133] ( 10s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[1011.973372] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[1011.978284] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[1012.063179] [117/133] ( 10s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[1012.155583] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[1016.654331] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.502s)
[1017.830070] [118/133] (  4s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[1017.926410] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[1025.393263] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.469s)
[1025.478566] Overall timeout time exceeded, stopping.
[1025.494769] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: sysfs_timeslice_duration
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: drm_buddy
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: perf_pmu
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_exec_balancer
results: parsing output: 15/ for test: kms_joiner
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: gem_wait
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_lease
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: api_intel_bb
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_pm_rpm
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_color_pipeline
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: prime_mmap
results: parsing output: 34/ for test: kms_atomic_transition
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_selftest
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: testdisplay
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: i915_selftest
results: parsing output: 48/ for test: gem_partial_pwrite_pread
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_async_flips
results: parsing output: 55/ for test: sw_sync
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: gem_ctx_persistence
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: perf_pmu
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_flush
results: parsing output: 70/ for test: kms_dither
results: parsing output: 71/ for test: gem_madvise
results: parsing output: 72/ for test: kms_plane_alpha_blend
results: parsing output: 73/ for test: kms_pipe_b_c_ivb
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_mmap_offset
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_nop
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_alignment
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: gem_ctx_exec
results: parsing output: 89/ for test: gem_busy
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: vgem_basic
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_scaling_modes
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_exec_parallel
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_create
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_close_race
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: gen9_exec_parse
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 119/ for test: gem_exec_balancer
results: no output, setting notrun
results: parsing output: 120/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 121/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 122/ for test: perf_pmu
results: no output, setting notrun
results: parsing output: 123/ for test: kms_force_connector_basic
results: no output, setting notrun
results: parsing output: 124/ for test: gem_ctx_param
results: no output, setting notrun
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 126/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 127/ for test: kms_flip
results: no output, setting notrun
results: parsing output: 128/ for test: kms_plane_scaling
results: no output, setting notrun
results: parsing output: 129/ for test: gem_exec_whisper
results: no output, setting notrun
results: parsing output: 130/ for test: kms_plane_lowres
results: no output, setting notrun
results: parsing output: 131/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 132/ for test: prime_vgem
results: no output, setting notrun
Done.