[67.985268] Initializing watchdogs
[67.985343]   /dev/watchdog0
[68.016353] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[68.031284] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.036560] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.039986] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[69.791946] Starting subtest: cursor-offscreen-256x85
[69.811441] Starting dynamic subtest: pipe-A-HDMI-A-4
[72.323221] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.514s)
[72.355668] Starting dynamic subtest: pipe-D-HDMI-A-4
[74.738215] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.390s)
[74.739730] Subtest cursor-offscreen-256x85: SUCCESS (4.945s)
[75.048616] [002/133] (953s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[76.538794] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[76.540482] Starting dynamic subtest: pipe-A-HDMI-A-4
[76.586201] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s)
[76.595221] Starting dynamic subtest: pipe-B-HDMI-A-4
[76.637516] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s)
[76.645860] Starting dynamic subtest: pipe-C-HDMI-A-4
[76.686048] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s)
[76.694484] Starting dynamic subtest: pipe-D-HDMI-A-4
[76.739826] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s)
[76.743533] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.016s)
[76.816576] [003/133] (951s left) sysfs_timeslice_duration (duration)
[76.874467] Starting subtest: duration
[76.876186] Starting dynamic subtest: vecs0
[90.018179] Dynamic subtest vecs0: SUCCESS (13.147s)
[90.028108] Starting dynamic subtest: vcs0
[103.159878] Dynamic subtest vcs0: SUCCESS (13.142s)
[103.170175] Starting dynamic subtest: bcs0
[116.295311] Dynamic subtest bcs0: SUCCESS (13.135s)
[116.305651] Starting dynamic subtest: rcs0
[129.439992] Dynamic subtest rcs0: SUCCESS (13.145s)
[129.450332] Starting dynamic subtest: vcs1
[142.574901] Dynamic subtest vcs1: SUCCESS (13.134s)
[142.576485] Subtest duration: SUCCESS (65.708s)
[142.691443] [004/133] (886s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[144.178104] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[144.179538] Starting dynamic subtest: pipe-A-HDMI-A-4
[144.185270] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[144.193960] Starting dynamic subtest: pipe-B-HDMI-A-4
[144.200047] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[144.208709] Starting dynamic subtest: pipe-C-HDMI-A-4
[144.214641] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[144.222907] Starting dynamic subtest: pipe-D-HDMI-A-4
[144.228833] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[144.231831] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[144.416382] [005/133] (884s left) drm_buddy (drm_buddy)
[144.464201] Starting subtest: drm_buddy
[144.467666] Subtest drm_buddy: SKIP (0.001s)
[144.561172] [006/133] (884s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[146.073363] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[146.673220] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.601s)
[146.890900] [007/133] (882s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[148.377530] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[148.379204] Starting dynamic subtest: pipe-A-HDMI-A-4
[148.397405] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[148.406532] Starting dynamic subtest: pipe-B-HDMI-A-4
[148.425053] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[148.433898] Starting dynamic subtest: pipe-C-HDMI-A-4
[148.455702] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[148.464480] Starting dynamic subtest: pipe-D-HDMI-A-4
[148.484201] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[148.488103] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[148.611121] [008/133] (880s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[150.098395] Starting subtest: bad-pixel-format-yf-tiled-ccs
[150.099705] Starting dynamic subtest: pipe-A-HDMI-A-4
[150.112750] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[150.121492] Starting dynamic subtest: pipe-B-HDMI-A-4
[150.134686] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[150.143164] Starting dynamic subtest: pipe-C-HDMI-A-4
[150.158960] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[150.167094] Starting dynamic subtest: pipe-D-HDMI-A-4
[150.181265] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[150.184270] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.006s)
[150.322432] [009/133] (878s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[150.370186] Starting subtest: multi-wait-available-unsubmitted-submitted
[150.371890] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[150.492938] [010/133] (878s left) perf_pmu (event-wait)
[150.544094] Starting subtest: event-wait
[150.547868] Starting dynamic subtest: rcs0
[150.551413] Dynamic subtest rcs0: SKIP (0.000s)
[150.554963] Subtest event-wait: SKIP (0.000s)
[150.665457] [011/133] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[152.161108] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[152.164310] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[152.329919] [012/133] (877s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[153.832326] Starting subtest: psr-rgb565-draw-mmap-gtt
[153.835432] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[153.990518] [013/133] (875s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[155.492256] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[155.570299] [014/133] (873s left) kms_psr (fbc-psr2-dpms)
[157.126330] Subtest fbc-psr2-dpms: SKIP (0.000s)
[157.201465] [015/133] (872s left) gem_exec_balancer (parallel-ordering)
[157.626398] Starting subtest: parallel-ordering
[159.773846] Subtest parallel-ordering: SUCCESS (2.147s)
[159.939942] [016/133] (869s left) kms_joiner (basic-big-joiner)
[161.428108] Starting subtest: basic-big-joiner
[161.430897] Subtest basic-big-joiner: SKIP (0.000s)
[161.524938] [017/133] (868s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[163.013818] Starting subtest: flip-vs-cursor-crc-atomic
[163.553361] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.540s)
[163.736680] [018/133] (866s left) gem_wait (wait)
[163.803239] Starting subtest: wait
[163.804909] Starting dynamic subtest: all-engines
[164.893887] Dynamic subtest all-engines: SUCCESS (1.092s)
[164.905939] Starting dynamic subtest: rcs0
[165.952133] Dynamic subtest rcs0: SUCCESS (1.057s)
[165.989191] Starting dynamic subtest: bcs0
[167.017246] Dynamic subtest bcs0: SUCCESS (1.064s)
[167.030838] Starting dynamic subtest: vcs0
[168.079369] Dynamic subtest vcs0: SUCCESS (1.061s)
[168.092900] Starting dynamic subtest: vcs1
[169.139248] Dynamic subtest vcs1: SUCCESS (1.058s)
[169.150664] Starting dynamic subtest: vecs0
[170.199415] Dynamic subtest vecs0: SUCCESS (1.059s)
[170.202286] Subtest wait: SUCCESS (6.397s)
[170.493391] [019/133] (859s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[171.989192] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[171.992405] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[172.132283] [020/133] (857s left) kms_flip (2x-flip-vs-expired-vblank)
[173.636675] Starting subtest: 2x-flip-vs-expired-vblank
[173.653099] Subtest 2x-flip-vs-expired-vblank: SKIP (0.018s)
[173.793655] [021/133] (856s left) kms_lease (page-flip-implicit-plane)
[175.292489] Starting subtest: page-flip-implicit-plane
[175.294046] Starting dynamic subtest: pipe-A-HDMI-A-4
[175.718400] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.426s)
[175.728791] Starting dynamic subtest: pipe-B-HDMI-A-4
[175.967272] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.246s)
[175.977186] Starting dynamic subtest: pipe-C-HDMI-A-4
[176.234334] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.266s)
[176.243580] Starting dynamic subtest: pipe-D-HDMI-A-4
[176.471650] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.235s)
[176.473707] Subtest page-flip-implicit-plane: SUCCESS (1.179s)
[176.661422] [022/133] (853s left) gem_exec_params (rsvd2-dirt)
[176.714189] Starting subtest: rsvd2-dirt
[176.717488] Subtest rsvd2-dirt: SKIP (0.000s)
[176.864290] [023/133] (853s left) api_intel_bb (blit-reloc-purge-cache)
[176.912318] Starting subtest: blit-reloc-purge-cache
[176.915849] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[177.079417] [024/133] (853s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[178.572653] Starting subtest: fbc-shrfb-scaledprimary
[182.265892] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.695s)
[182.459914] [025/133] (847s left) i915_pm_rpm (gem-idle)
[185.979877] Starting subtest: gem-idle
[191.973141] Subtest gem-idle: SUCCESS (5.996s)
[192.698276] [026/133] (837s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[194.211831] Starting subtest: x-tiled-8bpp-rotate-0
[195.870849] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.657s)
[196.085010] [027/133] (834s left) gem_exec_schedule (preempt-contexts)
[196.147996] Starting subtest: preempt-contexts
[196.149611] Starting dynamic subtest: rcs0
[196.235146] Dynamic subtest rcs0: SUCCESS (0.087s)
[196.244470] Starting dynamic subtest: bcs0
[196.303766] Dynamic subtest bcs0: SUCCESS (0.068s)
[196.313162] Starting dynamic subtest: vcs0
[196.380474] Dynamic subtest vcs0: SUCCESS (0.067s)
[196.389694] Starting dynamic subtest: vcs1
[196.438798] Dynamic subtest vcs1: SUCCESS (0.068s)
[196.447844] Starting dynamic subtest: vecs0
[196.507589] Dynamic subtest vecs0: SUCCESS (0.068s)
[196.509221] Subtest preempt-contexts: SUCCESS (0.360s)
[196.933643] [028/133] (833s left) gem_exec_flush (basic-uc-rw-default)
[196.986966] Subtest basic-uc-rw-default: SKIP (0.000s)
[197.078800] [029/133] (833s left) kms_color_pipeline (plane-lut1d)
[198.565461] Starting subtest: plane-lut1d
[198.770059] Starting dynamic subtest: pipe-A-plane-0
[199.019808] Dynamic subtest pipe-A-plane-0: SUCCESS (0.250s)
[199.054430] Starting dynamic subtest: pipe-A-plane-1
[199.236521] Dynamic subtest pipe-A-plane-1: SUCCESS (0.215s)
[199.257120] Starting dynamic subtest: pipe-A-plane-2
[199.420112] Dynamic subtest pipe-A-plane-2: SUCCESS (0.181s)
[199.723853] Starting dynamic subtest: pipe-B-plane-0
[199.900928] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s)
[199.925221] Starting dynamic subtest: pipe-B-plane-1
[200.086853] Dynamic subtest pipe-B-plane-1: SUCCESS (0.181s)
[200.113977] Starting dynamic subtest: pipe-B-plane-2
[200.286732] Dynamic subtest pipe-B-plane-2: SUCCESS (0.198s)
[200.556112] Starting dynamic subtest: pipe-C-plane-0
[200.727102] Dynamic subtest pipe-C-plane-0: SUCCESS (0.183s)
[200.740775] Starting dynamic subtest: pipe-C-plane-1
[200.910497] Dynamic subtest pipe-C-plane-1: SUCCESS (0.181s)
[200.934975] Starting dynamic subtest: pipe-C-plane-2
[201.110502] Dynamic subtest pipe-C-plane-2: SUCCESS (0.198s)
[201.386779] Starting dynamic subtest: pipe-D-plane-0
[201.559950] Dynamic subtest pipe-D-plane-0: SUCCESS (0.183s)
[201.584829] Starting dynamic subtest: pipe-D-plane-1
[201.760136] Dynamic subtest pipe-D-plane-1: SUCCESS (0.198s)
[201.788209] Starting dynamic subtest: pipe-D-plane-2
[201.976875] Dynamic subtest pipe-D-plane-2: SUCCESS (0.215s)
[202.032568] Subtest plane-lut1d: SUCCESS (3.466s)
[202.209352] [030/133] (828s left) gem_exec_schedule (deep)
[202.388990] Starting subtest: deep
[202.390494] Starting dynamic subtest: rcs0
[218.268762] Dynamic subtest rcs0: SUCCESS (15.877s)
[218.278470] Starting dynamic subtest: bcs0
[234.492175] Dynamic subtest bcs0: SUCCESS (16.223s)
[234.501942] Starting dynamic subtest: vcs0
[250.732555] Dynamic subtest vcs0: SUCCESS (16.240s)
[250.743378] Starting dynamic subtest: vcs1
[267.140601] Dynamic subtest vcs1: SUCCESS (16.405s)
[267.150299] Starting dynamic subtest: vecs0
[283.233896] Dynamic subtest vecs0: SUCCESS (16.094s)
[283.235334] Subtest deep: SUCCESS (80.844s)
[284.264762] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[284.267367] [031/133] (746s left) kms_cursor_crc (cursor-suspend)
[285.814830] Starting subtest: cursor-suspend
[285.816410] Starting dynamic subtest: pipe-A-HDMI-A-4
[329.045964] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (20.816s)
[329.057720] Starting dynamic subtest: pipe-D-HDMI-A-4
[372.990285] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (20.130s)
[372.991848] Subtest cursor-suspend: SUCCESS (40.950s)
[379.663046] [032/133] (657s left) perf (gen8-unprivileged-single-ctx-counters)
[379.799954] Starting subtest: gen8-unprivileged-single-ctx-counters
[379.802956] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[379.878481] [033/133] (657s left) api_intel_bb (intel-bb-blit-y)
[379.925878] Starting subtest: intel-bb-blit-y
[381.572684] Subtest intel-bb-blit-y: SUCCESS (1.646s)
[381.733742] [034/133] (655s left) prime_mmap (test_refcounting)
[381.781999] Starting subtest: test_refcounting
[381.783642] Starting dynamic subtest: test_refcounting-smem
[381.848014] Dynamic subtest test_refcounting-smem: SUCCESS (0.066s)
[381.859557] Starting dynamic subtest: test_refcounting-lmem0
[381.913913] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.066s)
[381.915554] Subtest test_refcounting: SUCCESS (0.133s)
[382.029929] [035/133] (655s left) kms_atomic_transition (modeset-transition)
[383.536893] Starting subtest: modeset-transition
[383.538430] Starting dynamic subtest: 1x-outputs
[385.498379] Dynamic subtest 1x-outputs: SUCCESS (1.961s)
[385.501368] Subtest modeset-transition: SUCCESS (1.963s)
[385.677320] [036/133] (651s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[387.166040] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[387.167753] Starting dynamic subtest: pipe-A
[387.966242] Dynamic subtest pipe-A: SUCCESS (0.802s)
[387.979475] Starting dynamic subtest: pipe-B
[388.724794] Dynamic subtest pipe-B: SUCCESS (0.758s)
[388.738473] Starting dynamic subtest: pipe-C
[389.481883] Dynamic subtest pipe-C: SUCCESS (0.756s)
[389.495609] Starting dynamic subtest: pipe-D
[390.238751] Dynamic subtest pipe-D: SUCCESS (0.756s)
[390.240365] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.075s)
[390.463851] [037/133] (646s left) kms_frontbuffer_tracking (fbc-suspend)
[391.962402] Starting subtest: fbc-suspend
[437.546186] Subtest fbc-suspend: SUCCESS (23.323s)
[441.778970] [038/133] (599s left) gem_pxp (display-protected-crc)
[444.348702] Starting subtest: display-protected-crc
[444.351723] Subtest display-protected-crc: SKIP (0.000s)
[444.472081] [039/133] (596s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[445.967018] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[445.969837] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[446.136564] [040/133] (595s left) gem_userptr_blits (dmabuf-unsync)
[446.198997] Subtest dmabuf-unsync: SKIP (0.000s)
[446.429956] [041/133] (595s left) gem_eio (context-create)
[446.623910] Starting subtest: context-create
[446.908313] Subtest context-create: SUCCESS (0.285s)
[448.475075] [042/133] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[449.977901] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[449.980692] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[450.156638] [043/133] (591s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[451.654173] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[451.656948] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[451.822025] [044/133] (590s left) kms_selftest (drm_dp_mst_helper)
[451.949246] Starting subtest: drm_dp_mst_helper
[452.063159] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[452.138145] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.073s)
[452.171263] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[452.247296] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.106s)
[452.284187] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[452.357171] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.108s)
[452.359129] Subtest drm_dp_mst_helper: SUCCESS (0.413s)
[452.555267] [045/133] (589s left) gem_spin_batch (resubmit-new)
[452.615022] Starting subtest: resubmit-new
[452.616561] Starting dynamic subtest: rcs0
[452.635046] Dynamic subtest rcs0: SUCCESS (0.021s)
[452.648804] Starting dynamic subtest: bcs0
[452.650370] Dynamic subtest bcs0: SUCCESS (0.005s)
[452.663751] Starting dynamic subtest: vcs0
[452.665396] Dynamic subtest vcs0: SUCCESS (0.006s)
[452.677903] Starting dynamic subtest: vcs1
[452.679612] Dynamic subtest vcs1: SUCCESS (0.006s)
[452.691920] Starting dynamic subtest: vecs0
[452.693642] Dynamic subtest vecs0: SUCCESS (0.005s)
[452.695466] Subtest resubmit-new: SUCCESS (0.047s)
[452.980922] [046/133] (589s left) testdisplay
[459.306435] [047/133] (582s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[460.800676] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[460.883454] [048/133] (581s left) i915_selftest (live)
[461.874364] Starting subtest: live
[461.876118] Starting dynamic subtest: sanitycheck
[463.301364] Dynamic subtest sanitycheck: SUCCESS (1.427s)
[463.311350] Starting dynamic subtest: uncore
[464.705450] Dynamic subtest uncore: SUCCESS (1.403s)
[464.715617] Starting dynamic subtest: workarounds
[467.996121] Dynamic subtest workarounds: SUCCESS (3.290s)
[468.006129] Starting dynamic subtest: gt_engines
[469.933425] Dynamic subtest gt_engines: SUCCESS (1.936s)
[469.943613] Starting dynamic subtest: gt_timelines
[535.499482] Dynamic subtest gt_timelines: SUCCESS (65.560s)
[535.509506] Starting dynamic subtest: gt_contexts
[536.945106] Dynamic subtest gt_contexts: SUCCESS (1.445s)
[536.955597] Starting dynamic subtest: gt_lrc
[543.262087] Dynamic subtest gt_lrc: SUCCESS (6.316s)
[543.271846] Starting dynamic subtest: gt_mocs
[545.568905] Dynamic subtest gt_mocs: SUCCESS (2.306s)
[545.578961] Starting dynamic subtest: gt_pm
[549.573988] Dynamic subtest gt_pm: SUCCESS (4.004s)
[549.584052] Starting dynamic subtest: gt_heartbeat
[550.987484] Dynamic subtest gt_heartbeat: SUCCESS (1.412s)
[550.998241] Starting dynamic subtest: gt_tlb
[564.802242] Dynamic subtest gt_tlb: SUCCESS (13.816s)
[564.812078] Starting dynamic subtest: requests
[575.270327] Dynamic subtest requests: SUCCESS (10.468s)
[575.280158] Starting dynamic subtest: migrate
[579.801197] Dynamic subtest migrate: SUCCESS (4.530s)
[579.811501] Starting dynamic subtest: active
[581.214066] Dynamic subtest active: SUCCESS (1.412s)
[581.223978] Starting dynamic subtest: objects
[583.607901] Dynamic subtest objects: SUCCESS (2.393s)
[583.618233] Starting dynamic subtest: mman
[587.156016] Dynamic subtest mman: SUCCESS (3.547s)
[587.166548] Starting dynamic subtest: dmabuf
[588.642183] Dynamic subtest dmabuf: SUCCESS (1.485s)
[588.653237] Starting dynamic subtest: vma
[590.062117] Dynamic subtest vma: SUCCESS (1.419s)
[590.073122] Starting dynamic subtest: coherency
[600.091039] Dynamic subtest coherency: SUCCESS (10.028s)
[600.101433] Starting dynamic subtest: gtt
[609.088677] Dynamic subtest gtt: SUCCESS (8.996s)
[609.098806] Starting dynamic subtest: gem
[610.690042] Dynamic subtest gem: SUCCESS (1.600s)
[610.700481] Starting dynamic subtest: evict
[622.260382] Dynamic subtest evict: SUCCESS (11.569s)
[622.270482] Starting dynamic subtest: hugepages
[639.547735] Dynamic subtest hugepages: SUCCESS (17.287s)
[639.558231] Starting dynamic subtest: gem_contexts
[667.310953] Dynamic subtest gem_contexts: SUCCESS (27.763s)
[667.321346] Starting dynamic subtest: client
[668.792131] Dynamic subtest client: SUCCESS (1.480s)
[668.802890] Starting dynamic subtest: gem_migrate
[671.453956] Dynamic subtest gem_migrate: SUCCESS (2.661s)
[671.464265] Starting dynamic subtest: reset
[672.874245] Dynamic subtest reset: SUCCESS (1.419s)
[672.884884] Starting dynamic subtest: memory_region
[675.892188] Dynamic subtest memory_region: SUCCESS (3.017s)
[675.902438] Starting dynamic subtest: hangcheck
[703.901268] Dynamic subtest hangcheck: SUCCESS (28.009s)
[703.911284] Starting dynamic subtest: execlists
[705.287313] Dynamic subtest execlists: SUCCESS (1.384s)
[705.297676] Starting dynamic subtest: ring_submission
[706.683058] Dynamic subtest ring_submission: SUCCESS (1.395s)
[706.693336] Starting dynamic subtest: perf
[708.182063] Dynamic subtest perf: SUCCESS (1.497s)
[708.192177] Starting dynamic subtest: slpc
[714.094184] Dynamic subtest slpc: SUCCESS (5.911s)
[714.104751] Starting dynamic subtest: guc
[717.496272] Dynamic subtest guc: SUCCESS (3.401s)
[717.506991] Starting dynamic subtest: guc_multi_lrc
[718.913960] Dynamic subtest guc_multi_lrc: SUCCESS (1.416s)
[718.924461] Starting dynamic subtest: guc_hang
[721.100995] Dynamic subtest guc_hang: SUCCESS (2.186s)
[721.111057] Starting dynamic subtest: late_gt_pm
[722.549282] Dynamic subtest late_gt_pm: SUCCESS (1.447s)
[722.551296] Subtest live: SUCCESS (260.683s)
[722.595868] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[722.597005] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[722.600456] [049/133] (319s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[725.940515] Subtest writes-after-reads-uncached: SKIP (0.000s)
[726.029159] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[726.032626] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true
[726.036812] [050/133] (316s left) kms_getfb (getfb-handle-not-fb)
[727.529159] Starting subtest: getfb-handle-not-fb
[727.530716] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[727.731206] [051/133] (314s left) kms_psr (fbc-psr-sprite-plane-onoff)
[729.221938] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[729.301534] [052/133] (313s left) i915_hangman (gt-error-state-capture)
[729.364171] Starting subtest: gt-error-state-capture
[729.365787] Starting dynamic subtest: rcs0
[739.566356] Dynamic subtest rcs0: SUCCESS (10.202s)
[739.587284] Starting dynamic subtest: bcs0
[749.504240] Dynamic subtest bcs0: SUCCESS (9.936s)
[749.516399] Starting dynamic subtest: vcs0
[759.510490] Dynamic subtest vcs0: SUCCESS (10.005s)
[759.540321] Starting dynamic subtest: vcs1
[769.471516] Dynamic subtest vcs1: SUCCESS (9.959s)
[769.486543] Starting dynamic subtest: vecs0
[779.530474] Dynamic subtest vecs0: SUCCESS (10.058s)
[779.532129] Subtest gt-error-state-capture: SUCCESS (50.169s)
[779.735221] [053/133] (262s left) perf (invalid-open-flags)
[779.853769] Starting subtest: invalid-open-flags
[779.855412] Subtest invalid-open-flags: SUCCESS (0.000s)
[779.940295] [054/133] (262s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[781.433625] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[781.436698] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[781.649118] [055/133] (261s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[783.138660] Starting subtest: async-flip-with-page-flip-events-linear
[783.395577] Starting dynamic subtest: pipe-A-HDMI-A-4
[785.714065] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.315s)
[785.937093] Starting dynamic subtest: pipe-B-HDMI-A-4
[787.983197] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (2.053s)
[788.187430] Starting dynamic subtest: pipe-C-HDMI-A-4
[790.237717] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (2.058s)
[790.416549] Starting dynamic subtest: pipe-D-HDMI-A-4
[792.467706] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.058s)
[792.469520] Subtest async-flip-with-page-flip-events-linear: SUCCESS (9.329s)
[792.840519] [056/133] (250s left) sw_sync (alloc_fence)
[792.888168] Starting subtest: alloc_fence
[792.889842] Subtest alloc_fence: SUCCESS (0.000s)
[792.980146] [057/133] (250s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[794.470345] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[794.471946] Starting dynamic subtest: pipe-A-valid-mode
[795.655046] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.184s)
[795.656766] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (1.187s)
[795.845225] [058/133] (247s left) gem_ctx_persistence (heartbeat-close)
[795.918308] Starting subtest: heartbeat-close
[795.921146] Subtest heartbeat-close: SKIP (0.000s)
[796.058528] [059/133] (247s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[797.565805] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[797.569661] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[797.717505] [060/133] (245s left) kms_flip (2x-flip-vs-modeset)
[799.212482] Starting subtest: 2x-flip-vs-modeset
[799.229706] Subtest 2x-flip-vs-modeset: SKIP (0.017s)
[799.387783] [061/133] (243s left) sw_sync (alloc_timeline)
[799.436654] Starting subtest: alloc_timeline
[799.438493] Subtest alloc_timeline: SUCCESS (0.000s)
[799.544448] [062/133] (243s left) gem_exec_fence (syncobj-timeline-chain-engines)
[800.120062] Starting subtest: syncobj-timeline-chain-engines
[800.255029] Subtest syncobj-timeline-chain-engines: SUCCESS (0.135s)
[800.601461] [063/133] (242s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[802.090035] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[802.123754] Starting dynamic subtest: pipe-A-plane-0
[802.639337] Dynamic subtest pipe-A-plane-0: SUCCESS (0.516s)
[802.670150] Starting dynamic subtest: pipe-A-plane-3
[802.989785] Dynamic subtest pipe-A-plane-3: SUCCESS (0.347s)
[803.041658] Starting dynamic subtest: pipe-A-plane-5
[803.322455] Dynamic subtest pipe-A-plane-5: SUCCESS (0.329s)
[803.506023] Starting dynamic subtest: pipe-B-plane-0
[803.878903] Dynamic subtest pipe-B-plane-0: SUCCESS (0.383s)
[803.923769] Starting dynamic subtest: pipe-B-plane-3
[804.211651] Dynamic subtest pipe-B-plane-3: SUCCESS (0.328s)
[804.251195] Starting dynamic subtest: pipe-B-plane-5
[804.544877] Dynamic subtest pipe-B-plane-5: SUCCESS (0.330s)
[804.634633] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.545s)
[804.799430] [064/133] (238s left) perf_pmu (all-busy-check-all)
[804.851881] Starting subtest: all-busy-check-all
[805.434847] Subtest all-busy-check-all: SUCCESS (0.583s)
[805.576168] [065/133] (238s left) kms_chamelium_frames (hdmi-crc-single)
[807.108120] Subtest hdmi-crc-single: SKIP (0.000s)
[807.226431] [066/133] (236s left) kms_draw_crc (draw-method-mmap-wc)
[808.717237] Starting subtest: draw-method-mmap-wc
[808.720374] Subtest draw-method-mmap-wc: SKIP (0.000s)
[808.908541] [067/133] (234s left) kms_content_protection (atomic)
[810.474553] Starting subtest: atomic
[810.484639] Subtest atomic: SKIP (0.005s)
[810.681959] [068/133] (233s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[812.168421] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[812.169976] Starting dynamic subtest: pipe-A-HDMI-A-4
[812.187987] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[812.201829] Starting dynamic subtest: pipe-B-HDMI-A-4
[812.217143] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[812.230411] Starting dynamic subtest: pipe-C-HDMI-A-4
[812.246096] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[812.259801] Starting dynamic subtest: pipe-D-HDMI-A-4
[812.276683] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[812.279943] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.011s)
[812.439460] [069/133] (231s left) kms_psr (pr-primary-render)
[813.928791] Subtest pr-primary-render: SKIP (0.000s)
[814.016559] [070/133] (230s left) gem_exec_flush (basic-uc-ro-default)
[814.072125] Subtest basic-uc-ro-default: SKIP (0.000s)
[814.166529] [071/133] (230s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[815.656180] Starting subtest: fb-8bpc-vs-panel-8bpc
[815.660663] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.001s)
[815.873522] [072/133] (228s left) gem_madvise (dontneed-after-mmap)
[815.917853] Starting subtest: dontneed-after-mmap
[815.923500] Subtest dontneed-after-mmap: SUCCESS (0.004s)
[816.073996] [073/133] (228s left) kms_plane_alpha_blend (constant-alpha-mid)
[817.562943] Starting subtest: constant-alpha-mid
[817.829622] Starting dynamic subtest: pipe-A-HDMI-A-4
[818.523157] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.693s)
[818.539538] Starting dynamic subtest: pipe-D-HDMI-A-4
[819.209291] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.684s)
[819.210770] Subtest constant-alpha-mid: SUCCESS (1.650s)
[819.400282] [074/133] (225s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[819.449030] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[819.528798] [075/133] (225s left) kms_flip (2x-flip-vs-wf_vblank)
[821.018729] Starting subtest: 2x-flip-vs-wf_vblank
[821.036078] Subtest 2x-flip-vs-wf_vblank: SKIP (0.017s)
[821.186086] [076/133] (223s left) kms_cursor_crc (cursor-sliding-128x42)
[822.904874] Starting subtest: cursor-sliding-128x42
[822.912651] Starting dynamic subtest: pipe-A-HDMI-A-4
[827.319249] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.408s)
[827.357442] Starting dynamic subtest: pipe-D-HDMI-A-4
[831.650868] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.306s)
[831.652379] Subtest cursor-sliding-128x42: SUCCESS (8.747s)
[832.040824] [077/133] (212s left) kms_psr (psr2-suspend)
[833.528649] Subtest psr2-suspend: SKIP (0.000s)
[833.617817] [078/133] (211s left) gem_mmap_offset (open-flood)
[833.667327] Starting subtest: open-flood
[855.152001] Subtest open-flood: SUCCESS (21.488s)
[855.305965] [079/133] (189s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[856.804398] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[856.807667] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[856.983349] [080/133] (188s left) gem_exec_nop (basic-sequential)
[857.049631] Starting subtest: basic-sequential
[860.807187] Subtest basic-sequential: SUCCESS (3.761s)
[861.134207] [081/133] (184s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[862.631412] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[862.634993] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[862.740686] [082/133] (182s left) gem_mmap_gtt (basic-small-bo-tiledy)
[862.794190] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[862.867667] [083/133] (182s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[864.373549] Starting subtest: y-tiled-64bpp-rotate-90
[864.443144] Subtest y-tiled-64bpp-rotate-90: SKIP (0.069s)
[864.637353] [084/133] (180s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[866.131946] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[866.135332] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[866.394142] [085/133] (179s left) gem_exec_alignment (single)
[866.450452] Starting subtest: single
[866.466046] Subtest single: SUCCESS (0.008s)
[866.602305] [086/133] (179s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[868.098863] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[868.101367] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[868.300822] [087/133] (177s left) syncobj_timeline (etime-single-wait-submitted)
[868.349148] Starting subtest: etime-single-wait-submitted
[868.458442] Subtest etime-single-wait-submitted: SUCCESS (0.107s)
[868.623914] [088/133] (177s left) i915_drm_fdinfo (virtual-busy-all)
[868.675241] Starting subtest: virtual-busy-all
[868.678260] Subtest virtual-busy-all: SKIP (0.000s)
[868.789312] [089/133] (177s left) gem_ctx_exec (basic)
[868.837993] Starting subtest: basic
[868.842972] Subtest basic: SUCCESS (0.006s)
[869.025273] [090/133] (177s left) gem_busy (parallel)
[869.221479] Starting subtest: parallel
[869.223160] Starting dynamic subtest: rcs0
[869.322741] Dynamic subtest rcs0: SUCCESS (0.101s)
[869.339441] Starting dynamic subtest: bcs0
[869.380607] Dynamic subtest bcs0: SUCCESS (0.056s)
[869.399612] Starting dynamic subtest: vcs0
[869.441031] Dynamic subtest vcs0: SUCCESS (0.059s)
[869.473963] Starting dynamic subtest: vcs1
[869.511844] Dynamic subtest vcs1: SUCCESS (0.068s)
[869.536051] Starting dynamic subtest: vecs0
[869.577800] Dynamic subtest vecs0: SUCCESS (0.064s)
[869.579572] Subtest parallel: SUCCESS (0.357s)
[869.878592] [091/133] (176s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[869.929858] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[869.931680] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[870.047282] [092/133] (176s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[871.536034] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[871.537924] Starting dynamic subtest: pipe-A-valid-mode
[872.714027] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.179s)
[872.715734] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.181s)
[872.904465] [093/133] (173s left) kms_vblank (ts-continuation-dpms-rpm)
[874.392391] Starting subtest: ts-continuation-dpms-rpm
[874.394034] Starting dynamic subtest: pipe-A-HDMI-A-4
[876.824560] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.431s)
[876.843116] Starting dynamic subtest: pipe-D-HDMI-A-4
[878.838094] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.009s)
[878.839382] Subtest ts-continuation-dpms-rpm: SUCCESS (4.447s)
[879.014555] [094/133] (167s left) sw_sync (timeline_closed_signaled)
[879.074584] Starting subtest: timeline_closed_signaled
[879.079419] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[879.197075] [095/133] (167s left) gem_lmem_swapping (verify)
[883.417880] Starting subtest: verify
[883.419284] Starting dynamic subtest: lmem0
[924.422374] Dynamic subtest lmem0: SUCCESS (41.002s)
[924.423977] Subtest verify: SUCCESS (41.004s)
[925.789765] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[925.790960] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[925.794391] [096/133] (120s left) syncobj_wait (invalid-signal-zero-handles)
[928.371962] Starting subtest: invalid-signal-zero-handles
[928.373318] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[929.218848] [FACT syncobj_wait (invalid-signal-zero-handles)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[929.223268] [FACT syncobj_wait (invalid-signal-zero-handles)] new: kernel.kmod_is_loaded.i915: true
[929.228240] [097/133] (117s left) kms_pm_rpm (i2c)
[933.582320] Starting subtest: i2c
[938.225490] Subtest i2c: SUCCESS (4.645s)
[939.083216] [098/133] (107s left) vgem_basic (setversion)
[939.141019] Starting subtest: setversion
[939.144312] Subtest setversion: SUCCESS (0.000s)
[939.264862] [099/133] (107s left) gem_exec_reloc (basic-write-gtt)
[939.323757] Subtest basic-write-gtt: SKIP (0.000s)
[939.421346] [100/133] (107s left) kms_scaling_modes (scaling-mode-center)
[940.909532] Starting subtest: scaling-mode-center
[940.917667] Subtest scaling-mode-center: SKIP (0.002s)
[941.032772] [101/133] (105s left) perf_pmu (frequency)
[941.150394] Starting subtest: frequency
[941.154551] Starting dynamic subtest: gt0
[943.561745] Dynamic subtest gt0: FAIL (2.258s)
[943.603027] Starting dynamic subtest: idle-gt0
[943.923265] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[943.924692] Subtest frequency: FAIL (2.773s)
[944.059084] [102/133] (102s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[945.565359] Starting subtest: 4-tiled-32bpp-rotate-180
[945.568227] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[945.725084] [103/133] (101s left) kms_hdr (bpc-switch-dpms)
[947.215270] Starting subtest: bpc-switch-dpms
[947.222661] Subtest bpc-switch-dpms: SKIP (0.001s)
[947.329763] [104/133] ( 99s left) syncobj_timeline (wait-any-interrupted)
[947.384585] Starting subtest: wait-any-interrupted
[947.498878] Subtest wait-any-interrupted: SUCCESS (0.104s)
[947.700008] [105/133] ( 99s left) gem_exec_parallel (contexts)
[947.758169] Starting subtest: contexts
[947.759615] Starting dynamic subtest: rcs0
[952.185558] Dynamic subtest rcs0: SUCCESS (4.424s)
[952.198374] Starting dynamic subtest: bcs0
[955.997750] Dynamic subtest bcs0: SUCCESS (3.810s)
[956.010548] Starting dynamic subtest: vcs0
[960.061832] Dynamic subtest vcs0: SUCCESS (4.063s)
[960.074893] Starting dynamic subtest: vcs1
[964.276875] Dynamic subtest vcs1: SUCCESS (4.214s)
[964.290494] Starting dynamic subtest: vecs0
[968.067471] Dynamic subtest vecs0: SUCCESS (3.789s)
[968.069344] Subtest contexts: SUCCESS (20.307s)
[968.383230] [106/133] ( 79s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[970.956050] Starting subtest: verify-pxp-key-change-after-suspend-resume
[970.959414] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[971.091986] [107/133] ( 76s left) gem_create (create-ext-placement-each)
[971.277893] Starting subtest: create-ext-placement-each
[971.279748] Subtest create-ext-placement-each: SUCCESS (0.001s)
[971.430495] [108/133] ( 76s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[972.917311] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[972.918773] Starting dynamic subtest: pipe-A-HDMI-A-4
[972.933714] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s)
[972.946710] Starting dynamic subtest: pipe-B-HDMI-A-4
[972.962280] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s)
[972.975328] Starting dynamic subtest: pipe-C-HDMI-A-4
[972.990906] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s)
[973.004148] Starting dynamic subtest: pipe-D-HDMI-A-4
[973.020774] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s)
[973.024080] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.010s)
[973.205162] [109/133] ( 74s left) gem_close_race (basic-process)
[973.280386] Starting subtest: basic-process
[973.341563] Subtest basic-process: SUCCESS (0.061s)
[973.653451] [110/133] ( 74s left) gem_exec_schedule (u-independent)
[973.713748] Starting subtest: u-independent
[973.715291] Starting dynamic subtest: rcs0
[973.966643] Dynamic subtest rcs0: SUCCESS (0.253s)
[973.991156] Starting dynamic subtest: bcs0
[974.184617] Dynamic subtest bcs0: SUCCESS (0.216s)
[974.202828] Starting dynamic subtest: vcs0
[974.392772] Dynamic subtest vcs0: SUCCESS (0.206s)
[974.426636] Starting dynamic subtest: vcs1
[974.621255] Dynamic subtest vcs1: SUCCESS (0.226s)
[974.638251] Starting dynamic subtest: vecs0
[974.829628] Dynamic subtest vecs0: SUCCESS (0.206s)
[974.831351] Subtest u-independent: SUCCESS (1.118s)
[975.321473] [111/133] ( 72s left) gen9_exec_parse (batch-without-end)
[975.386323] Subtest batch-without-end: SKIP (0.000s)
[975.468014] [112/133] ( 72s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[979.595448] Starting subtest: dpms-mode-unset-lpsp
[980.553392] Subtest dpms-mode-unset-lpsp: SKIP (0.959s)
[981.612039] [113/133] ( 66s left) kms_chamelium_hpd (vga-hpd)
[983.147692] Subtest vga-hpd: SKIP (0.000s)
[983.263226] [114/133] ( 64s left) gem_lmem_swapping (heavy-multi)
[987.416551] Starting subtest: heavy-multi
[987.418244] Starting dynamic subtest: lmem0
[993.322362] Dynamic subtest lmem0: SUCCESS (5.902s)
[993.324078] Subtest heavy-multi: SUCCESS (5.904s)
[994.809419] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[994.810587] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[994.813487] [115/133] ( 53s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[999.598141] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[999.797087] [FACT kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[999.800571] [FACT kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)] new: kernel.kmod_is_loaded.i915: true
[999.808127] [116/133] ( 48s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[1001.333465] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[1001.339337] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[1001.518523] [117/133] ( 46s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[1003.013443] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[1006.021643] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.009s)
[1006.270385] [118/133] ( 42s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[1007.773444] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[1007.775996] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[1008.007932] [119/133] ( 40s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[1009.502995] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[1009.506153] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[1009.691423] [120/133] ( 39s left) gem_exec_balancer (noheartbeat)
[1010.126373] Starting subtest: noheartbeat
[1010.130585] Subtest noheartbeat: SKIP (0.000s)
[1010.295643] [121/133] ( 38s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[1010.344279] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[1010.448260] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[1010.615859] [122/133] ( 38s left) kms_big_fb (linear-addfb)
[1012.123258] Starting subtest: linear-addfb
[1012.125225] Subtest linear-addfb: SUCCESS (0.000s)
[1012.294442] [123/133] ( 36s left) perf_pmu (busy)
[1012.346681] Starting subtest: busy
[1012.348515] Starting dynamic subtest: rcs0
[1012.928283] Dynamic subtest rcs0: SUCCESS (0.582s)
[1012.946728] Starting dynamic subtest: bcs0
[1013.488849] Dynamic subtest bcs0: SUCCESS (0.559s)
[1013.506425] Starting dynamic subtest: vcs0
[1014.049848] Dynamic subtest vcs0: SUCCESS (0.559s)
[1014.066872] Starting dynamic subtest: vcs1
[1014.611854] Dynamic subtest vcs1: SUCCESS (0.560s)
[1014.629090] Starting dynamic subtest: vecs0
[1015.173476] Dynamic subtest vecs0: SUCCESS (0.558s)
[1015.179523] Subtest busy: SUCCESS (2.832s)
[1015.330744] [124/133] ( 33s left) kms_force_connector_basic (force-load-detect)
[1015.463131] Starting subtest: force-load-detect
[1015.465963] Subtest force-load-detect: SKIP (0.000s)
[1016.409918] [125/133] ( 32s left) gem_ctx_param (invalid-get-ringsize)
[1016.458730] Starting subtest: invalid-get-ringsize
[1016.460645] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[1016.576602] [126/133] ( 32s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[1018.069304] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[1018.072782] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[1018.265339] [127/133] ( 31s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[1019.753610] Starting subtest: cursorB-vs-flipA-varying-size
[1019.759380] Subtest cursorB-vs-flipA-varying-size: SKIP (0.003s)
[1019.884019] [128/133] ( 29s left) kms_flip (2x-blocking-wf_vblank)
[1021.381818] Starting subtest: 2x-blocking-wf_vblank
[1021.400222] Subtest 2x-blocking-wf_vblank: SKIP (0.017s)
[1021.534354] [129/133] ( 28s left) kms_plane_scaling (planes-downscale-factor-0-75)
[1023.026214] Starting subtest: planes-downscale-factor-0-75
[1023.027642] Starting dynamic subtest: pipe-A
[1023.136295] Dynamic subtest pipe-A: SUCCESS (0.110s)
[1023.150164] Starting dynamic subtest: pipe-B
[1023.277737] Dynamic subtest pipe-B: SUCCESS (0.140s)
[1023.290387] Starting dynamic subtest: pipe-C
[1023.418485] Dynamic subtest pipe-C: SUCCESS (0.139s)
[1023.431190] Starting dynamic subtest: pipe-D
[1023.557905] Dynamic subtest pipe-D: SUCCESS (0.138s)
[1023.559266] Subtest planes-downscale-factor-0-75: SUCCESS (0.533s)
[1023.750601] [130/133] ( 26s left) gem_exec_whisper (basic-fds-forked-all)
[1023.812165] Starting subtest: basic-fds-forked-all
[1035.737671] Subtest basic-fds-forked-all: SUCCESS (11.921s)
[1035.983811] [131/133] ( 13s left) kms_plane_lowres (tiling-none)
[1037.471610] Starting subtest: tiling-none
[1037.473324] Starting dynamic subtest: pipe-A-HDMI-A-4
[1046.851048] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.380s)
[1046.938111] Starting dynamic subtest: pipe-B-HDMI-A-4
[1056.123141] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (9.198s)
[1056.208988] Starting dynamic subtest: pipe-C-HDMI-A-4
[1065.436235] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (9.240s)
[1065.522600] Starting dynamic subtest: pipe-D-HDMI-A-4
[1074.753029] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.243s)
[1074.839018] Subtest tiling-none: SUCCESS (37.358s)
[1074.967338] Overall timeout time exceeded, stopping.
[1075.014913] 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: parsing output: 119/ for test: gem_exec_balancer
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_force_connector_basic
results: parsing output: 124/ for test: gem_ctx_param
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: kms_plane_lowres
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.