[56.985691] Initializing watchdogs
[56.985746]   /dev/watchdog0
[56.999733] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.003969] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.006504] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.009968] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[57.295373] Starting subtest: cursor-offscreen-256x85
[57.345839] Subtest cursor-offscreen-256x85: SKIP (0.044s)
[57.504470] [002/133] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[57.605259] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[57.607640] Starting dynamic subtest: pipe-A-eDP-1
[57.665873] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[57.674383] Starting dynamic subtest: pipe-B-eDP-1
[57.733060] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[57.743780] Starting dynamic subtest: pipe-C-eDP-1
[57.802908] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[57.811162] Starting dynamic subtest: pipe-D-eDP-1
[57.868774] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[57.872821] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[59.920146] [003/133] (957s left) sysfs_timeslice_duration (duration)
[59.975476] Starting subtest: duration
[59.977965] Starting dynamic subtest: vecs0
[74.804860] Dynamic subtest vecs0: SUCCESS (14.795s)
[74.814876] Starting dynamic subtest: ccs0
[87.955137] Dynamic subtest ccs0: SUCCESS (13.144s)
[87.966109] Starting dynamic subtest: vcs0
[101.811260] Dynamic subtest vcs0: SUCCESS (13.848s)
[101.821991] Starting dynamic subtest: bcs0
[114.967819] Dynamic subtest bcs0: SUCCESS (13.132s)
[114.976765] Starting dynamic subtest: rcs0
[128.101754] Dynamic subtest rcs0: SUCCESS (13.135s)
[128.113536] Starting dynamic subtest: vcs1
[142.835425] Dynamic subtest vcs1: SUCCESS (14.749s)
[142.838160] Subtest duration: SUCCESS (82.812s)
[142.920227] [004/133] (874s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[143.019086] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[143.021132] Starting dynamic subtest: pipe-A-eDP-1
[159.472129] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.553s)
[159.482215] Starting dynamic subtest: pipe-B-eDP-1
[176.453326] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.414s)
[176.462681] Starting dynamic subtest: pipe-C-eDP-1
[193.416750] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.303s)
[193.425228] Starting dynamic subtest: pipe-D-eDP-1
[210.465223] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.379s)
[210.468055] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.651s)
[211.720649] [005/133] (805s left) drm_buddy (drm_buddy)
[211.770805] Starting subtest: drm_buddy
[211.776384] Subtest drm_buddy: SKIP (0.001s)
[211.826653] [006/133] (805s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[211.927995] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[212.792650] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.848s)
[212.982476] [007/133] (804s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[213.080551] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[213.082876] Starting dynamic subtest: pipe-A-eDP-1
[213.796557] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[213.804885] Starting dynamic subtest: pipe-B-eDP-1
[215.604593] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.777s)
[215.613541] Starting dynamic subtest: pipe-C-eDP-1
[217.360121] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.733s)
[217.369798] Starting dynamic subtest: pipe-D-eDP-1
[219.108729] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.730s)
[219.111592] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.939s)
[220.273769] [008/133] (797s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[220.363001] Starting subtest: bad-pixel-format-yf-tiled-ccs
[220.365771] Starting dynamic subtest: pipe-A-eDP-1
[220.393493] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[220.403491] Starting dynamic subtest: pipe-B-eDP-1
[220.429695] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[220.437784] Starting dynamic subtest: pipe-C-eDP-1
[220.463571] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[220.471595] Starting dynamic subtest: pipe-D-eDP-1
[220.497791] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[220.502837] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[222.648228] [009/133] (795s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[222.725851] Starting subtest: multi-wait-available-unsubmitted-submitted
[222.728722] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[222.829435] [010/133] (795s left) perf_pmu (event-wait)
[222.870517] Starting subtest: event-wait
[222.873079] Starting dynamic subtest: rcs0
[222.877975] Dynamic subtest rcs0: SKIP (0.000s)
[222.883114] Subtest event-wait: SKIP (0.000s)
[222.971889] [011/133] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[223.066738] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[223.072466] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[223.175254] [012/133] (794s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[223.263997] Starting subtest: psr-rgb565-draw-mmap-gtt
[223.269001] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[223.364568] [013/133] (794s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[223.460167] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[223.462520] Starting dynamic subtest: pipe-A-eDP-1
[229.353130] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.873s)
[229.363214] Starting dynamic subtest: pipe-B-eDP-1
[236.021695] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.653s)
[236.024640] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.528s)
[236.894748] [014/133] (781s left) kms_psr (fbc-psr2-dpms)
[237.002608] Starting subtest: fbc-psr2-dpms
[237.005316] Starting dynamic subtest: eDP-1
[237.010464] Dynamic subtest eDP-1: SKIP (0.000s)
[237.015698] Subtest fbc-psr2-dpms: SKIP (0.001s)
[237.072023] [015/133] (780s left) gem_exec_balancer (parallel-ordering)
[237.332620] Starting subtest: parallel-ordering
[238.278110] Subtest parallel-ordering: SUCCESS (0.944s)
[238.410333] [016/133] (779s left) kms_joiner (basic-big-joiner)
[238.510719] Starting subtest: basic-big-joiner
[238.516737] Subtest basic-big-joiner: SKIP (0.000s)
[238.572695] [017/133] (779s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[238.689833] Starting subtest: flip-vs-cursor-crc-atomic
[239.388745] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.699s)
[240.236435] [018/133] (777s left) gem_wait (wait)
[240.310482] Starting subtest: wait
[240.313303] Starting dynamic subtest: all-engines
[241.500509] Dynamic subtest all-engines: SUCCESS (1.188s)
[241.512852] Starting dynamic subtest: rcs0
[242.550904] Dynamic subtest rcs0: SUCCESS (1.050s)
[242.562745] Starting dynamic subtest: bcs0
[243.602115] Dynamic subtest bcs0: SUCCESS (1.050s)
[243.612775] Starting dynamic subtest: vcs0
[244.653546] Dynamic subtest vcs0: SUCCESS (1.049s)
[244.665079] Starting dynamic subtest: vcs1
[245.701702] Dynamic subtest vcs1: SUCCESS (1.048s)
[245.713349] Starting dynamic subtest: vecs0
[246.751788] Dynamic subtest vecs0: SUCCESS (1.049s)
[246.762875] Starting dynamic subtest: ccs0
[247.801321] Dynamic subtest ccs0: SUCCESS (1.048s)
[247.804461] Subtest wait: SUCCESS (7.493s)
[247.997765] [019/133] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[248.103845] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[248.108626] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[248.197098] [020/133] (770s left) kms_flip (2x-flip-vs-expired-vblank)
[248.297466] Starting subtest: 2x-flip-vs-expired-vblank
[248.305453] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[248.421101] [021/133] (769s left) kms_lease (page-flip-implicit-plane)
[248.512776] Starting subtest: page-flip-implicit-plane
[248.515559] Starting dynamic subtest: pipe-A-eDP-1
[249.000572] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.486s)
[249.010087] Starting dynamic subtest: pipe-B-eDP-1
[250.181520] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.181s)
[250.191287] Starting dynamic subtest: pipe-C-eDP-1
[251.283243] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[251.300641] Starting dynamic subtest: pipe-D-eDP-1
[252.415057] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[252.417786] Subtest page-flip-implicit-plane: SUCCESS (3.903s)
[253.245598] [022/133] (765s left) gem_exec_params (rsvd2-dirt)
[253.310586] Starting subtest: rsvd2-dirt
[253.315675] Subtest rsvd2-dirt: SKIP (0.000s)
[253.401162] [023/133] (764s left) api_intel_bb (blit-reloc-purge-cache)
[253.455111] Starting subtest: blit-reloc-purge-cache
[253.460739] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[253.592786] [024/133] (764s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[253.693311] Starting subtest: fbc-shrfb-scaledprimary
[256.619033] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.932s)
[257.764083] [025/133] (760s left) i915_pm_rpm (gem-idle)
[259.699181] Starting subtest: gem-idle
[265.912863] Subtest gem-idle: SUCCESS (6.203s)
[266.263488] [026/133] (752s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[267.501747] Starting subtest: x-tiled-8bpp-rotate-0
[268.760608] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.259s)
[268.871851] [027/133] (749s left) gem_exec_schedule (preempt-contexts)
[268.938354] Starting subtest: preempt-contexts
[268.940320] Starting dynamic subtest: rcs0
[268.992125] Dynamic subtest rcs0: SUCCESS (0.060s)
[269.000251] Starting dynamic subtest: bcs0
[269.055694] Dynamic subtest bcs0: SUCCESS (0.063s)
[269.067498] Starting dynamic subtest: vcs0
[269.104433] Dynamic subtest vcs0: SUCCESS (0.048s)
[269.113302] Starting dynamic subtest: vcs1
[269.151366] Dynamic subtest vcs1: SUCCESS (0.047s)
[269.163685] Starting dynamic subtest: vecs0
[269.194420] Dynamic subtest vecs0: SUCCESS (0.043s)
[269.202238] Starting dynamic subtest: ccs0
[269.239115] Dynamic subtest ccs0: SUCCESS (0.043s)
[269.241108] Subtest preempt-contexts: SUCCESS (0.307s)
[270.648626] [028/133] (747s left) gem_exec_flush (basic-uc-rw-default)
[270.720690] Starting subtest: basic-uc-rw-default
[276.220563] Subtest basic-uc-rw-default: SUCCESS (5.464s)
[276.367203] [029/133] (742s left) kms_color_pipeline (plane-lut1d)
[276.462626] Starting subtest: plane-lut1d
[276.588119] Starting dynamic subtest: pipe-A-plane-0
[276.948008] Dynamic subtest pipe-A-plane-0: FAIL (0.165s)
[276.957828] Starting dynamic subtest: pipe-A-plane-1
[277.195435] Dynamic subtest pipe-A-plane-1: FAIL (0.165s)
[277.204595] Starting dynamic subtest: pipe-A-plane-2
[277.441532] Dynamic subtest pipe-A-plane-2: FAIL (0.188s)
[278.331864] Starting dynamic subtest: pipe-B-plane-0
[278.789441] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[278.797791] Starting dynamic subtest: pipe-B-plane-1
[279.155577] Dynamic subtest pipe-B-plane-1: FAIL (0.155s)
[279.165948] Starting dynamic subtest: pipe-B-plane-2
[279.494429] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[280.592302] Starting dynamic subtest: pipe-C-plane-0
[281.166283] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[281.176082] Starting dynamic subtest: pipe-C-plane-1
[281.614899] Dynamic subtest pipe-C-plane-1: FAIL (0.155s)
[281.623773] Starting dynamic subtest: pipe-C-plane-2
[282.048170] Dynamic subtest pipe-C-plane-2: FAIL (0.698s)
[282.819014] Starting dynamic subtest: pipe-D-plane-0
[283.448571] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[283.457764] Starting dynamic subtest: pipe-D-plane-1
[283.951094] Dynamic subtest pipe-D-plane-1: FAIL (0.632s)
[283.958824] Starting dynamic subtest: pipe-D-plane-2
[284.458675] Dynamic subtest pipe-D-plane-2: FAIL (0.619s)
[284.524333] Subtest plane-lut1d: FAIL (8.057s)
[285.375453] [030/133] (733s left) gem_exec_schedule (deep)
[285.555532] Starting subtest: deep
[285.558281] Starting dynamic subtest: rcs0
[290.532069] Dynamic subtest rcs0: SKIP (4.971s)
[290.543145] Starting dynamic subtest: vcs0
[301.302465] Dynamic subtest vcs0: SUCCESS (10.766s)
[301.316372] Starting dynamic subtest: vcs1
[312.458166] Dynamic subtest vcs1: SUCCESS (11.157s)
[312.474326] Starting dynamic subtest: vecs0
[324.066681] Dynamic subtest vecs0: SUCCESS (11.606s)
[324.079015] Starting dynamic subtest: ccs0
[336.186068] Dynamic subtest ccs0: SUCCESS (12.121s)
[336.188702] Subtest deep: SUCCESS (50.630s)
[337.479365] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[337.483146] [031/133] (681s left) kms_cursor_crc (cursor-suspend)
[337.616114] Starting subtest: cursor-suspend
[337.618769] Starting dynamic subtest: pipe-A-eDP-1
[370.723909] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.150s)
[370.734171] Starting dynamic subtest: pipe-D-eDP-1
[404.741795] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.738s)
[404.744281] Subtest cursor-suspend: SUCCESS (6.891s)
[405.602324] [032/133] (613s left) perf (gen8-unprivileged-single-ctx-counters)
[405.749720] Starting subtest: gen8-unprivileged-single-ctx-counters
[405.754078] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[405.797185] [033/133] (612s left) api_intel_bb (intel-bb-blit-y)
[405.857801] Starting subtest: intel-bb-blit-y
[409.507689] Subtest intel-bb-blit-y: SUCCESS (3.584s)
[409.637985] [034/133] (609s left) prime_mmap (test_refcounting)
[409.701728] Starting subtest: test_refcounting
[409.704021] Starting dynamic subtest: test_refcounting-smem
[409.734490] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s)
[409.737245] Subtest test_refcounting: SUCCESS (0.034s)
[409.827249] [035/133] (609s left) kms_atomic_transition (modeset-transition)
[409.926080] Starting subtest: modeset-transition
[409.928787] Starting dynamic subtest: 1x-outputs
[420.809675] Dynamic subtest 1x-outputs: SUCCESS (10.803s)
[420.812211] Subtest modeset-transition: SUCCESS (10.805s)
[421.684341] [036/133] (597s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[421.771966] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[421.774099] Starting dynamic subtest: pipe-A
[421.791226] Dynamic subtest pipe-A: SKIP (0.016s)
[421.800385] Starting dynamic subtest: pipe-B
[421.820705] Dynamic subtest pipe-B: SKIP (0.029s)
[421.829084] Starting dynamic subtest: pipe-C
[421.854275] Dynamic subtest pipe-C: SKIP (0.032s)
[421.863329] Starting dynamic subtest: pipe-D
[421.883046] Dynamic subtest pipe-D: SKIP (0.029s)
[421.887435] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.109s)
[421.985511] [037/133] (596s left) kms_frontbuffer_tracking (fbc-suspend)
[422.079157] Starting subtest: fbc-suspend
[459.815578] Subtest fbc-suspend: SUCCESS (7.508s)
[461.039514] [038/133] (557s left) gem_pxp (display-protected-crc)
[461.180797] Starting subtest: display-protected-crc
[462.898676] Subtest display-protected-crc: SUCCESS (1.694s)
[463.004548] [039/133] (556s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[463.098253] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[463.103149] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[463.209780] [040/133] (555s left) gem_userptr_blits (dmabuf-unsync)
[463.274917] Subtest dmabuf-unsync: SKIP (0.000s)
[463.400904] [041/133] (555s left) gem_eio (context-create)
[463.617671] Starting subtest: context-create
[463.937154] Subtest context-create: SUCCESS (0.315s)
[464.053392] [042/133] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[464.145354] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[470.997731] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.802s)
[471.109171] [043/133] (548s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[471.216517] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[471.220969] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[471.307484] [044/133] (547s left) kms_selftest (drm_dp_mst_helper)
[471.352255] Starting subtest: drm_dp_mst_helper
[471.458129] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[471.553214] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.094s)
[471.563129] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[471.660026] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.105s)
[471.669598] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[471.769703] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.108s)
[471.771858] Subtest drm_dp_mst_helper: SUCCESS (0.416s)
[471.928708] [045/133] (547s left) gem_spin_batch (resubmit-new)
[471.982805] Starting subtest: resubmit-new
[471.984953] Starting dynamic subtest: rcs0
[471.993065] Dynamic subtest rcs0: SUCCESS (0.010s)
[472.002740] Starting dynamic subtest: bcs0
[472.004942] Dynamic subtest bcs0: SUCCESS (0.004s)
[472.013798] Starting dynamic subtest: vcs0
[472.015933] Dynamic subtest vcs0: SUCCESS (0.004s)
[472.025096] Starting dynamic subtest: vcs1
[472.027937] Dynamic subtest vcs1: SUCCESS (0.005s)
[472.037081] Starting dynamic subtest: vecs0
[472.039534] Dynamic subtest vecs0: SUCCESS (0.004s)
[472.047977] Starting dynamic subtest: ccs0
[472.050364] Dynamic subtest ccs0: SUCCESS (0.005s)
[472.052982] Subtest resubmit-new: SUCCESS (0.037s)
[473.904094] [046/133] (545s left) testdisplay
[474.221586] [047/133] (545s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[474.313068] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[474.315933] Starting dynamic subtest: pipe-A-eDP-1
[474.448177] Dynamic subtest pipe-A-eDP-1: SKIP (0.140s)
[474.458181] Starting dynamic subtest: pipe-B-eDP-1
[475.628070] Dynamic subtest pipe-B-eDP-1: SKIP (1.174s)
[475.632950] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.316s)
[476.821631] [048/133] (542s left) i915_selftest (live)
[478.457857] Starting subtest: live
[478.460642] Starting dynamic subtest: sanitycheck
[483.623033] Dynamic subtest sanitycheck: SUCCESS (5.156s)
[483.631210] Starting dynamic subtest: uncore
[487.501868] Dynamic subtest uncore: SUCCESS (3.871s)
[487.511767] Starting dynamic subtest: workarounds
[491.384388] Dynamic subtest workarounds: SUCCESS (3.876s)
[491.393611] Starting dynamic subtest: gt_engines
[495.291855] Dynamic subtest gt_engines: SUCCESS (3.902s)
[495.299970] Starting dynamic subtest: gt_timelines
[511.750130] Dynamic subtest gt_timelines: SUCCESS (16.445s)
[511.759450] Starting dynamic subtest: gt_contexts
[516.937478] Dynamic subtest gt_contexts: SUCCESS (5.183s)
[516.947324] Starting dynamic subtest: gt_lrc
[522.068133] Dynamic subtest gt_lrc: SUCCESS (5.127s)
[522.083149] Starting dynamic subtest: gt_mocs
[525.870705] Dynamic subtest gt_mocs: SUCCESS (3.798s)
[525.880905] Starting dynamic subtest: gt_pm
[531.445670] Dynamic subtest gt_pm: SUCCESS (5.570s)
[531.455613] Starting dynamic subtest: gt_heartbeat
[536.621057] Dynamic subtest gt_heartbeat: SUCCESS (5.171s)
[536.631124] Starting dynamic subtest: gt_tlb
[546.776773] Dynamic subtest gt_tlb: SUCCESS (10.148s)
[546.787337] Starting dynamic subtest: requests
[559.041497] Dynamic subtest requests: SUCCESS (12.279s)
[559.051322] Starting dynamic subtest: migrate
[565.680098] Dynamic subtest migrate: SUCCESS (6.650s)
[565.692447] Starting dynamic subtest: active
[569.223984] Dynamic subtest active: SUCCESS (3.548s)
[569.232824] Starting dynamic subtest: objects
[573.434196] Dynamic subtest objects: SUCCESS (4.212s)
[573.443422] Starting dynamic subtest: mman
[577.572230] Dynamic subtest mman: SUCCESS (4.140s)
[577.581751] Starting dynamic subtest: dmabuf
[581.103810] Dynamic subtest dmabuf: SUCCESS (3.533s)
[581.113940] Starting dynamic subtest: vma
[584.614203] Dynamic subtest vma: SUCCESS (3.511s)
[584.621754] Starting dynamic subtest: coherency
[589.387824] Dynamic subtest coherency: SUCCESS (4.772s)
[589.401200] Starting dynamic subtest: gtt
[599.534429] Dynamic subtest gtt: SUCCESS (10.148s)
[599.548140] Starting dynamic subtest: gem
[608.517641] Dynamic subtest gem: SUCCESS (8.983s)
[608.527833] Starting dynamic subtest: evict
[613.348720] Dynamic subtest evict: SUCCESS (4.830s)
[613.358783] Starting dynamic subtest: hugepages
[622.888510] Dynamic subtest hugepages: SUCCESS (9.538s)
[622.900391] Starting dynamic subtest: gem_contexts
[650.662992] Dynamic subtest gem_contexts: SUCCESS (27.773s)
[650.672228] Starting dynamic subtest: client
[654.316934] Dynamic subtest client: SUCCESS (3.651s)
[654.326483] Starting dynamic subtest: gem_migrate
[657.801913] Dynamic subtest gem_migrate: SUCCESS (3.484s)
[657.814337] Starting dynamic subtest: reset
[662.906749] Dynamic subtest reset: SUCCESS (5.103s)
[662.922009] Starting dynamic subtest: memory_region
[666.402611] Dynamic subtest memory_region: SUCCESS (3.494s)
[666.413002] Starting dynamic subtest: hangcheck
[680.022363] Dynamic subtest hangcheck: SUCCESS (13.618s)
[680.032311] Starting dynamic subtest: execlists
[683.493640] Dynamic subtest execlists: SUCCESS (3.470s)
[683.502211] Starting dynamic subtest: ring_submission
[687.010136] Dynamic subtest ring_submission: SUCCESS (3.514s)
[687.021036] Starting dynamic subtest: perf
[690.644536] Dynamic subtest perf: SUCCESS (3.633s)
[690.655602] Starting dynamic subtest: slpc
[703.425133] Dynamic subtest slpc: SUCCESS (12.778s)
[703.434948] Starting dynamic subtest: guc
[708.208431] Dynamic subtest guc: SUCCESS (4.782s)
[708.221114] Starting dynamic subtest: guc_multi_lrc
[713.360443] Dynamic subtest guc_multi_lrc: SUCCESS (5.150s)
[713.368815] Starting dynamic subtest: guc_hang
[717.608977] Dynamic subtest guc_hang: SUCCESS (4.246s)
[717.617700] Starting dynamic subtest: late_gt_pm
[722.776119] Dynamic subtest late_gt_pm: SUCCESS (5.166s)
[722.779047] Subtest live: SUCCESS (244.318s)
[722.810633] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[722.811340] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[722.815771] [049/133] (296s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[725.139139] Subtest writes-after-reads-uncached: SKIP (0.000s)
[725.225286] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[725.226583] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true
[725.230989] [050/133] (294s left) kms_getfb (getfb-handle-not-fb)
[725.331854] Starting subtest: getfb-handle-not-fb
[725.334330] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[725.424383] [051/133] (294s left) kms_psr (fbc-psr-sprite-plane-onoff)
[725.507990] Starting subtest: fbc-psr-sprite-plane-onoff
[725.510625] Starting dynamic subtest: eDP-1
[725.515234] Dynamic subtest eDP-1: SKIP (0.000s)
[725.519989] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[725.583224] [052/133] (294s left) i915_hangman (gt-error-state-capture)
[725.652186] Starting subtest: gt-error-state-capture
[725.654971] Starting dynamic subtest: rcs0
[736.803484] Dynamic subtest rcs0: SUCCESS (11.151s)
[736.819579] Starting dynamic subtest: bcs0
[748.773833] Dynamic subtest bcs0: SUCCESS (11.967s)
[748.785919] Starting dynamic subtest: vcs0
[760.739728] Dynamic subtest vcs0: SUCCESS (11.963s)
[760.752188] Starting dynamic subtest: vcs1
[771.746749] Dynamic subtest vcs1: SUCCESS (11.003s)
[771.761206] Starting dynamic subtest: vecs0
[782.753952] Dynamic subtest vecs0: SUCCESS (11.004s)
[782.767004] Starting dynamic subtest: ccs0
[794.787195] Dynamic subtest ccs0: SUCCESS (12.029s)
[794.790199] Subtest gt-error-state-capture: SUCCESS (69.134s)
[794.871486] [053/133] (224s left) perf (invalid-open-flags)
[795.048067] Starting subtest: invalid-open-flags
[795.050836] Subtest invalid-open-flags: SUCCESS (0.000s)
[795.098284] [054/133] (224s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[795.219960] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[795.225091] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[795.299909] [055/133] (224s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[795.398971] Starting subtest: async-flip-with-page-flip-events-linear
[795.769868] Starting dynamic subtest: pipe-A-eDP-1
[798.580339] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.809s)
[798.945083] Starting dynamic subtest: pipe-B-eDP-1
[801.713565] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.776s)
[802.096702] Starting dynamic subtest: pipe-C-eDP-1
[804.842878] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.750s)
[805.201843] Starting dynamic subtest: pipe-D-eDP-1
[807.968342] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s)
[807.971218] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.571s)
[809.152918] [056/133] (210s left) sw_sync (alloc_fence)
[809.197049] Starting subtest: alloc_fence
[809.200010] Subtest alloc_fence: SUCCESS (0.000s)
[809.253532] [057/133] (210s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[809.340191] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[809.342959] Starting dynamic subtest: pipe-A-default-mode
[810.516995] Dynamic subtest pipe-A-default-mode: SKIP (1.173s)
[810.521958] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.174s)
[810.661933] [058/133] (209s left) gem_ctx_persistence (heartbeat-close)
[810.714753] Starting subtest: heartbeat-close
[810.720121] Subtest heartbeat-close: SKIP (0.000s)
[810.821940] [059/133] (209s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[810.922080] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[810.927132] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[811.021556] [060/133] (208s left) kms_flip (2x-flip-vs-modeset)
[811.121827] Starting subtest: 2x-flip-vs-modeset
[811.129332] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[811.248291] [061/133] (208s left) sw_sync (alloc_timeline)
[811.293591] Starting subtest: alloc_timeline
[811.296063] Subtest alloc_timeline: SUCCESS (0.000s)
[811.354343] [062/133] (208s left) gem_exec_fence (syncobj-timeline-chain-engines)
[811.890905] Starting subtest: syncobj-timeline-chain-engines
[812.021600] Subtest syncobj-timeline-chain-engines: SUCCESS (0.131s)
[812.871755] [063/133] (207s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[812.978996] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[812.984196] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[813.057572] [064/133] (207s left) perf_pmu (all-busy-check-all)
[813.098578] Starting subtest: all-busy-check-all
[814.787980] Subtest all-busy-check-all: SUCCESS (1.693s)
[814.887429] [065/133] (205s left) kms_chamelium_frames (hdmi-crc-single)
[815.274391] Subtest hdmi-crc-single: SKIP (0.000s)
[816.098773] [066/133] (204s left) kms_draw_crc (draw-method-mmap-wc)
[816.184077] Starting subtest: draw-method-mmap-wc
[816.186645] Starting dynamic subtest: xrgb8888-untiled
[816.449086] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[816.459191] Starting dynamic subtest: rgb565-untiled
[816.671635] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[816.681740] Starting dynamic subtest: xrgb2101010-untiled
[816.893922] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[816.903458] Starting dynamic subtest: xbgr16161616f-untiled
[817.126717] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[817.138748] Starting dynamic subtest: xrgb8888-xtiled
[817.271139] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.142s)
[817.281531] Starting dynamic subtest: rgb565-xtiled
[817.404785] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[817.414797] Starting dynamic subtest: xrgb2101010-xtiled
[817.515757] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[817.525309] Starting dynamic subtest: xbgr16161616f-xtiled
[817.637937] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[817.647229] Starting dynamic subtest: xrgb8888-4tiled
[817.782441] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[817.791238] Starting dynamic subtest: rgb565-4tiled
[817.926624] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[817.935486] Starting dynamic subtest: xrgb2101010-4tiled
[818.082459] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[818.094092] Starting dynamic subtest: xbgr16161616f-4tiled
[818.260060] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[818.263047] Subtest draw-method-mmap-wc: SUCCESS (2.079s)
[818.343097] [067/133] (201s left) kms_content_protection (atomic)
[818.476459] Starting subtest: atomic
[818.481310] Subtest atomic: SKIP (0.000s)
[818.589663] [068/133] (201s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[818.678656] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[818.680871] Starting dynamic subtest: pipe-A-eDP-1
[818.703845] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[818.715447] Starting dynamic subtest: pipe-B-eDP-1
[818.737205] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[818.746115] Starting dynamic subtest: pipe-C-eDP-1
[818.768634] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[818.776906] Starting dynamic subtest: pipe-D-eDP-1
[818.801199] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[818.805892] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[820.901050] [069/133] (199s left) kms_psr (pr-primary-render)
[820.991241] Starting subtest: pr-primary-render
[820.996729] Subtest pr-primary-render: SKIP (0.000s)
[821.061069] [070/133] (199s left) gem_exec_flush (basic-uc-ro-default)
[821.128983] Starting subtest: basic-uc-ro-default
[826.629792] Subtest basic-uc-ro-default: SUCCESS (5.457s)
[826.783551] [071/133] (193s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[826.884085] Starting subtest: fb-8bpc-vs-panel-8bpc
[826.886650] Starting dynamic subtest: pipe-A-eDP-1
[828.285064] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.400s)
[828.287834] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.402s)
[829.156594] [072/133] (191s left) gem_madvise (dontneed-after-mmap)
[829.200720] Starting subtest: dontneed-after-mmap
[829.220348] Subtest dontneed-after-mmap: SUCCESS (0.022s)
[829.351994] [073/133] (191s left) kms_plane_alpha_blend (constant-alpha-mid)
[829.445893] Starting subtest: constant-alpha-mid
[829.726623] Starting dynamic subtest: pipe-A-eDP-1
[830.534752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[830.544720] Starting dynamic subtest: pipe-D-eDP-1
[832.009824] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.472s)
[832.012792] Subtest constant-alpha-mid: SUCCESS (2.565s)
[832.800144] [074/133] (187s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[832.864046] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[832.925667] [075/133] (187s left) kms_flip (2x-flip-vs-wf_vblank)
[833.032935] Starting subtest: 2x-flip-vs-wf_vblank
[833.044004] Subtest 2x-flip-vs-wf_vblank: SKIP (0.012s)
[833.120718] [076/133] (187s left) kms_cursor_crc (cursor-sliding-128x42)
[833.359809] Starting subtest: cursor-sliding-128x42
[833.406859] Subtest cursor-sliding-128x42: SKIP (0.040s)
[833.623557] [077/133] (186s left) kms_psr (psr2-suspend)
[833.729708] Starting subtest: psr2-suspend
[833.732042] Starting dynamic subtest: eDP-1
[851.674213] Dynamic subtest eDP-1: SUCCESS (2.900s)
[851.676494] Subtest psr2-suspend: SUCCESS (2.902s)
[852.555628] [078/133] (168s left) gem_mmap_offset (open-flood)
[852.617799] Starting subtest: open-flood
[874.118938] Subtest open-flood: SUCCESS (21.488s)
[874.224020] [079/133] (146s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[874.337887] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[874.341389] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[874.434803] [080/133] (146s left) gem_exec_nop (basic-sequential)
[874.503656] Starting subtest: basic-sequential
[889.374046] Subtest basic-sequential: SUCCESS (14.850s)
[889.574076] [081/133] (131s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[889.672092] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[889.676656] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[889.758076] [082/133] (131s left) gem_mmap_gtt (basic-small-bo-tiledy)
[889.814401] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[889.879561] [083/133] (130s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[889.991807] Starting subtest: y-tiled-64bpp-rotate-90
[889.996262] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[890.117030] [084/133] (130s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[890.216570] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[898.816998] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.604s)
[898.927085] [085/133] (122s left) gem_exec_alignment (single)
[898.985384] Starting subtest: single
[898.990692] Subtest single: SUCCESS (0.003s)
[899.112448] [086/133] (121s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[899.206848] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[899.210925] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[899.298956] [087/133] (121s left) syncobj_timeline (etime-single-wait-submitted)
[899.348379] Starting subtest: etime-single-wait-submitted
[899.453521] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[899.548035] [088/133] (121s left) i915_drm_fdinfo (virtual-busy-all)
[899.589084] Starting subtest: virtual-busy-all
[899.593489] Subtest virtual-busy-all: SKIP (0.000s)
[899.673666] [089/133] (121s left) gem_ctx_exec (basic)
[899.724613] Starting subtest: basic
[899.729605] Subtest basic: SUCCESS (0.006s)
[899.842989] [090/133] (121s left) gem_busy (parallel)
[900.030597] Starting subtest: parallel
[900.032989] Starting dynamic subtest: rcs0
[901.835028] Dynamic subtest rcs0: SUCCESS (1.807s)
[901.847472] Starting dynamic subtest: bcs0
[903.820742] Dynamic subtest bcs0: SUCCESS (1.982s)
[903.833256] Starting dynamic subtest: vcs0
[905.919167] Dynamic subtest vcs0: SUCCESS (2.041s)
[905.930262] Starting dynamic subtest: vcs1
[907.850778] Dynamic subtest vcs1: SUCCESS (1.982s)
[907.863945] Starting dynamic subtest: vecs0
[909.950765] Dynamic subtest vecs0: SUCCESS (2.045s)
[909.962422] Starting dynamic subtest: ccs0
[911.883082] Dynamic subtest ccs0: SUCCESS (1.981s)
[911.885852] Subtest parallel: SUCCESS (11.855s)
[912.085535] [091/133] (109s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[912.139882] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[912.142159] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[912.233691] [092/133] (109s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[912.327606] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[912.331473] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[912.403059] [093/133] (108s left) kms_vblank (ts-continuation-dpms-rpm)
[912.511169] Starting subtest: ts-continuation-dpms-rpm
[912.513434] Starting dynamic subtest: pipe-A-eDP-1
[915.095403] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.579s)
[915.111220] Starting dynamic subtest: pipe-D-eDP-1
[917.325236] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.228s)
[917.327624] Subtest ts-continuation-dpms-rpm: SUCCESS (4.812s)
[918.204281] [094/133] (103s left) sw_sync (timeline_closed_signaled)
[918.248610] Starting subtest: timeline_closed_signaled
[918.250908] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[918.305505] [095/133] (103s left) gem_lmem_swapping (verify)
[918.347705] Subtest verify: SKIP (0.000s)
[918.391562] [096/133] (103s left) syncobj_wait (invalid-signal-zero-handles)
[918.446279] Starting subtest: invalid-signal-zero-handles
[918.448589] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[918.535903] [097/133] (102s left) kms_pm_rpm (i2c)
[920.059075] Starting subtest: i2c
[925.790613] Subtest i2c: SUCCESS (5.727s)
[925.883100] [098/133] ( 95s left) vgem_basic (setversion)
[925.927262] Starting subtest: setversion
[925.931726] Subtest setversion: SUCCESS (0.000s)
[925.981590] [099/133] ( 95s left) gem_exec_reloc (basic-write-gtt)
[926.048747] Subtest basic-write-gtt: SKIP (0.000s)
[926.115716] [100/133] ( 95s left) kms_scaling_modes (scaling-mode-center)
[926.206230] Starting subtest: scaling-mode-center
[926.208478] Starting dynamic subtest: pipe-A-eDP-1
[926.297861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[926.307417] Starting dynamic subtest: pipe-B-eDP-1
[927.491405] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.191s)
[927.504363] Starting dynamic subtest: pipe-C-eDP-1
[928.610341] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[928.620637] Starting dynamic subtest: pipe-D-eDP-1
[929.756962] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s)
[929.759343] Subtest scaling-mode-center: SUCCESS (3.553s)
[930.907725] [101/133] ( 90s left) perf_pmu (frequency)
[930.955130] Starting subtest: frequency
[930.957599] Starting dynamic subtest: gt0
[933.076743] Dynamic subtest gt0: SUCCESS (2.115s)
[933.088255] Starting dynamic subtest: idle-gt0
[933.582106] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[933.594354] Starting dynamic subtest: gt1
[937.845028] Dynamic subtest gt1: SUCCESS (4.257s)
[937.856016] Starting dynamic subtest: idle-gt1
[938.391959] Dynamic subtest idle-gt1: SUCCESS (0.546s)
[938.394693] Subtest frequency: SUCCESS (7.439s)
[938.487413] [102/133] ( 83s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[938.589089] Starting subtest: 4-tiled-32bpp-rotate-180
[940.024001] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.434s)
[940.159164] [103/133] ( 81s left) kms_hdr (bpc-switch-dpms)
[940.246667] Starting subtest: bpc-switch-dpms
[941.284663] Starting dynamic subtest: pipe-A-eDP-1
[945.811630] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.529s)
[945.814060] Subtest bpc-switch-dpms: SUCCESS (5.567s)
[945.925666] [104/133] ( 75s left) syncobj_timeline (wait-any-interrupted)
[945.982154] Starting subtest: wait-any-interrupted
[946.083094] Subtest wait-any-interrupted: SUCCESS (0.102s)
[946.161238] [105/133] ( 75s left) gem_exec_parallel (contexts)
[946.220856] Starting subtest: contexts
[946.223570] Starting dynamic subtest: rcs0
[949.186296] Dynamic subtest rcs0: SUCCESS (2.963s)
[949.198812] Starting dynamic subtest: bcs0
[952.549389] Dynamic subtest bcs0: SUCCESS (3.363s)
[952.565480] Starting dynamic subtest: vcs0
[956.381835] Dynamic subtest vcs0: SUCCESS (3.829s)
[956.394868] Starting dynamic subtest: vcs1
[960.360065] Dynamic subtest vcs1: SUCCESS (3.976s)
[960.373047] Starting dynamic subtest: vecs0
[964.448084] Dynamic subtest vecs0: SUCCESS (4.088s)
[964.461168] Starting dynamic subtest: ccs0
[968.517406] Dynamic subtest ccs0: SUCCESS (4.066s)
[968.520771] Subtest contexts: SUCCESS (22.296s)
[968.703976] [106/133] ( 53s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[968.820373] Starting subtest: verify-pxp-key-change-after-suspend-resume
[975.999114] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.181s)
[976.116971] [107/133] ( 45s left) gem_create (create-ext-placement-each)
[976.285522] Starting subtest: create-ext-placement-each
[976.288473] Subtest create-ext-placement-each: SUCCESS (0.000s)
[976.388748] [108/133] ( 45s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[976.480400] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[976.482564] Starting dynamic subtest: pipe-A-eDP-1
[976.502682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[976.514016] Starting dynamic subtest: pipe-B-eDP-1
[976.533540] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[976.543222] Starting dynamic subtest: pipe-C-eDP-1
[976.562662] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[976.574212] Starting dynamic subtest: pipe-D-eDP-1
[976.593550] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[976.595988] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[978.745161] [109/133] ( 43s left) gem_close_race (basic-process)
[978.823105] Starting subtest: basic-process
[978.886618] Subtest basic-process: SUCCESS (0.063s)
[979.074710] [110/133] ( 42s left) gem_exec_schedule (u-independent)
[979.152468] Starting subtest: u-independent
[979.154551] Starting dynamic subtest: rcs0
[980.873766] Dynamic subtest rcs0: SUCCESS (1.729s)
[980.887151] Starting dynamic subtest: vcs0
[982.867035] Dynamic subtest vcs0: SUCCESS (1.990s)
[982.878162] Starting dynamic subtest: vcs1
[984.849428] Dynamic subtest vcs1: SUCCESS (1.981s)
[984.863440] Starting dynamic subtest: vecs0
[986.898652] Dynamic subtest vecs0: SUCCESS (2.046s)
[986.911067] Starting dynamic subtest: ccs0
[988.896784] Dynamic subtest ccs0: SUCCESS (1.972s)
[988.900919] Subtest u-independent: SUCCESS (9.730s)
[989.179045] [111/133] ( 32s left) gen9_exec_parse (batch-without-end)
[989.243539] Subtest batch-without-end: SKIP (0.000s)
[989.313966] [112/133] ( 32s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[991.041465] Starting subtest: dpms-mode-unset-lpsp
[995.098381] Subtest dpms-mode-unset-lpsp: SUCCESS (4.061s)
[995.488846] [113/133] ( 26s left) kms_chamelium_hpd (vga-hpd)
[995.885485] Subtest vga-hpd: SKIP (0.000s)
[996.682496] [114/133] ( 25s left) gem_lmem_swapping (heavy-multi)
[996.730323] Subtest heavy-multi: SKIP (0.000s)
[996.768262] [115/133] ( 25s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[996.859922] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[996.863871] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[996.928989] [116/133] ( 25s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[997.026444] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[997.030258] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[997.134126] [117/133] ( 25s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[997.256019] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[1001.656236] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.404s)
[1002.818608] [118/133] ( 19s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[1002.917898] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[1010.392092] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.475s)
[1010.505198] [119/133] ( 11s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[1010.614531] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[1010.618862] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[1010.708803] [120/133] ( 11s left) gem_exec_balancer (noheartbeat)
[1010.970042] Starting subtest: noheartbeat
[1010.974838] Subtest noheartbeat: SKIP (0.000s)
[1011.079903] [121/133] ( 11s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[1011.140449] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[1011.247551] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[1011.320136] [122/133] ( 11s left) kms_big_fb (linear-addfb)
[1011.409949] Starting subtest: linear-addfb
[1011.412257] Subtest linear-addfb: SUCCESS (0.000s)
[1011.505856] [123/133] ( 10s left) perf_pmu (busy)
[1011.545426] Starting subtest: busy
[1011.547851] Starting dynamic subtest: rcs0
[1012.130076] Dynamic subtest rcs0: SUCCESS (0.586s)
[1012.143234] Starting dynamic subtest: bcs0
[1012.703240] Dynamic subtest bcs0: SUCCESS (0.571s)
[1012.715867] Starting dynamic subtest: vcs0
[1013.834233] Dynamic subtest vcs0: SUCCESS (1.127s)
[1013.848069] Starting dynamic subtest: vcs1
[1015.881827] Dynamic subtest vcs1: SUCCESS (2.045s)
[1015.896917] Starting dynamic subtest: vecs0
[1017.866564] Dynamic subtest vecs0: SUCCESS (1.981s)
[1017.879998] Starting dynamic subtest: ccs0
[1018.435232] Dynamic subtest ccs0: SUCCESS (0.567s)
[1018.437749] Subtest busy: SUCCESS (6.892s)
[1018.550250] [124/133] (  3s left) kms_force_connector_basic (force-load-detect)
[1018.632564] Starting subtest: force-load-detect
[1018.637052] Subtest force-load-detect: SKIP (0.000s)
[1018.748567] [125/133] (  3s left) gem_ctx_param (invalid-get-ringsize)
[1018.797958] Starting subtest: invalid-get-ringsize
[1018.800233] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[1018.908582] [126/133] (  3s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[1019.006928] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[1026.322056] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.319s)
[1026.441753] Overall timeout time exceeded, stopping.
[1026.457021] 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: 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.