[59.909791] Initializing watchdogs
[59.909839]   /dev/watchdog0
[59.943557] [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]
[59.947977] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.950331] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.952252] [001/133] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[60.205286] Starting subtest: cursor-offscreen-256x85
[60.255181] Subtest cursor-offscreen-256x85: SKIP (0.047s)
[60.418034] [002/133] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[60.502509] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[60.503645] Starting dynamic subtest: pipe-A-eDP-1
[60.529089] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[60.535168] Starting dynamic subtest: pipe-B-eDP-1
[60.554646] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[60.560485] Starting dynamic subtest: pipe-C-eDP-1
[60.579805] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[60.586215] Starting dynamic subtest: pipe-D-eDP-1
[60.606880] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[60.608539] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[62.823696] [003/133] (957s left) sysfs_timeslice_duration (duration)
[62.875740] Starting subtest: duration
[62.876729] Starting dynamic subtest: vecs0
[77.886556] Dynamic subtest vecs0: SUCCESS (14.986s)
[77.893891] Starting dynamic subtest: ccs0
[91.024608] Dynamic subtest ccs0: SUCCESS (13.145s)
[91.034607] Starting dynamic subtest: vcs0
[104.893011] Dynamic subtest vcs0: SUCCESS (13.857s)
[104.901375] Starting dynamic subtest: bcs0
[118.033874] Dynamic subtest bcs0: SUCCESS (13.137s)
[118.039920] Starting dynamic subtest: rcs0
[131.167365] Dynamic subtest rcs0: SUCCESS (13.143s)
[131.177257] Starting dynamic subtest: vcs1
[144.893060] Dynamic subtest vcs1: SUCCESS (13.714s)
[144.894311] Subtest duration: SUCCESS (81.991s)
[144.993510] [004/133] (875s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[145.083298] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[145.084339] Starting dynamic subtest: pipe-A-eDP-1
[162.074997] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.962s)
[162.082905] Starting dynamic subtest: pipe-B-eDP-1
[180.034268] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.789s)
[180.043040] Starting dynamic subtest: pipe-C-eDP-1
[198.009782] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.718s)
[198.018010] Starting dynamic subtest: pipe-D-eDP-1
[216.018939] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[216.019802] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.231s)
[223.266463] [005/133] (803s left) drm_buddy (drm_buddy)
[223.302162] Starting subtest: drm_buddy
[223.304116] Subtest drm_buddy: SKIP (0.001s)
[223.358280] [006/133] (803s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[223.456293] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[224.293349] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s)
[224.455867] [007/133] (802s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[224.538636] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[224.539737] Starting dynamic subtest: pipe-A-eDP-1
[225.282509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[225.290686] Starting dynamic subtest: pipe-B-eDP-1
[227.079528] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.796s)
[227.086498] Starting dynamic subtest: pipe-C-eDP-1
[228.905735] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.824s)
[228.912623] Starting dynamic subtest: pipe-D-eDP-1
[230.732674] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.826s)
[230.733710] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.191s)
[231.861875] [008/133] (794s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[231.948483] Starting subtest: bad-pixel-format-yf-tiled-ccs
[231.949389] Starting dynamic subtest: pipe-A-eDP-1
[231.957810] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[231.970933] Starting dynamic subtest: pipe-B-eDP-1
[231.980790] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.989843] Starting dynamic subtest: pipe-C-eDP-1
[231.998207] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.004788] Starting dynamic subtest: pipe-D-eDP-1
[232.013063] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.014677] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[234.136845] [009/133] (792s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[234.201708] Starting subtest: multi-wait-available-unsubmitted-submitted
[234.203480] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[234.291839] [010/133] (792s left) perf_pmu (event-wait)
[234.331795] Starting subtest: event-wait
[234.332824] Starting dynamic subtest: rcs0
[234.334755] Dynamic subtest rcs0: SKIP (0.000s)
[234.336587] Subtest event-wait: SKIP (0.000s)
[234.427686] [011/133] (792s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[234.521333] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[234.523318] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[234.615663] [012/133] (792s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[234.706829] Starting subtest: psr-rgb565-draw-mmap-gtt
[234.708522] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[234.808382] [013/133] (792s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[234.908050] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[234.909060] Starting dynamic subtest: pipe-A-eDP-1
[240.750023] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.841s)
[240.757791] Starting dynamic subtest: pipe-B-eDP-1
[247.421494] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.670s)
[247.422359] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.513s)
[248.297113] [014/133] (778s left) kms_psr (fbc-psr2-dpms)
[248.397581] Starting subtest: fbc-psr2-dpms
[248.398415] Starting dynamic subtest: eDP-1
[248.400185] Dynamic subtest eDP-1: SKIP (0.000s)
[248.401861] Subtest fbc-psr2-dpms: SKIP (0.001s)
[248.477240] [015/133] (778s left) gem_exec_balancer (parallel-ordering)
[248.754599] Starting subtest: parallel-ordering
[249.736980] Subtest parallel-ordering: SUCCESS (0.982s)
[249.834186] [016/133] (777s left) kms_joiner (basic-big-joiner)
[249.926436] Starting subtest: basic-big-joiner
[249.927926] Subtest basic-big-joiner: SKIP (0.000s)
[249.992407] [017/133] (777s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[250.107120] Starting subtest: flip-vs-cursor-crc-atomic
[250.821706] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.715s)
[251.612606] [018/133] (775s left) gem_wait (wait)
[251.671875] Starting subtest: wait
[251.672928] Starting dynamic subtest: all-engines
[253.629673] Dynamic subtest all-engines: SUCCESS (1.948s)
[253.642696] Starting dynamic subtest: rcs0
[254.668557] Dynamic subtest rcs0: SUCCESS (1.045s)
[254.677980] Starting dynamic subtest: bcs0
[255.714978] Dynamic subtest bcs0: SUCCESS (1.045s)
[255.725620] Starting dynamic subtest: vcs0
[256.759372] Dynamic subtest vcs0: SUCCESS (1.043s)
[256.769630] Starting dynamic subtest: vcs1
[257.803996] Dynamic subtest vcs1: SUCCESS (1.043s)
[257.813325] Starting dynamic subtest: vecs0
[258.848298] Dynamic subtest vecs0: SUCCESS (1.043s)
[258.857605] Starting dynamic subtest: ccs0
[259.894111] Dynamic subtest ccs0: SUCCESS (1.044s)
[259.895183] Subtest wait: SUCCESS (8.222s)
[260.083609] [019/133] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[260.184847] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[260.186426] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[260.265152] [020/133] (766s left) kms_flip (2x-flip-vs-expired-vblank)
[260.355665] Starting subtest: 2x-flip-vs-expired-vblank
[260.366190] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[260.458296] [021/133] (766s left) kms_lease (page-flip-implicit-plane)
[260.547655] Starting subtest: page-flip-implicit-plane
[260.548616] Starting dynamic subtest: pipe-A-eDP-1
[261.037861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.489s)
[261.047841] Starting dynamic subtest: pipe-B-eDP-1
[262.163148] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.121s)
[262.170970] Starting dynamic subtest: pipe-C-eDP-1
[263.284060] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[263.291896] Starting dynamic subtest: pipe-D-eDP-1
[264.420470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[264.421879] Subtest page-flip-implicit-plane: SUCCESS (3.873s)
[265.255780] [022/133] (761s left) gem_exec_params (rsvd2-dirt)
[265.312502] Starting subtest: rsvd2-dirt
[265.314453] Subtest rsvd2-dirt: SKIP (0.000s)
[265.395957] [023/133] (761s left) api_intel_bb (blit-reloc-purge-cache)
[265.443446] Starting subtest: blit-reloc-purge-cache
[265.445176] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[265.544718] [024/133] (761s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[265.633500] Starting subtest: fbc-shrfb-scaledprimary
[268.661695] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.028s)
[269.853770] [025/133] (757s left) i915_pm_rpm (gem-idle)
[271.793783] Starting subtest: gem-idle
[278.009629] Subtest gem-idle: SUCCESS (6.169s)
[278.336608] [026/133] (749s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[279.622123] Starting subtest: x-tiled-8bpp-rotate-0
[280.824218] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.192s)
[280.934015] [027/133] (746s left) gem_exec_schedule (preempt-contexts)
[281.007726] Starting subtest: preempt-contexts
[281.008740] Starting dynamic subtest: rcs0
[281.062321] Dynamic subtest rcs0: SUCCESS (0.055s)
[281.070704] Starting dynamic subtest: bcs0
[281.116151] Dynamic subtest bcs0: SUCCESS (0.053s)
[281.124079] Starting dynamic subtest: vcs0
[281.163630] Dynamic subtest vcs0: SUCCESS (0.046s)
[281.172521] Starting dynamic subtest: vcs1
[281.220890] Dynamic subtest vcs1: SUCCESS (0.057s)
[281.228434] Starting dynamic subtest: vecs0
[281.267005] Dynamic subtest vecs0: SUCCESS (0.045s)
[281.280178] Starting dynamic subtest: ccs0
[281.320637] Dynamic subtest ccs0: SUCCESS (0.052s)
[281.321619] Subtest preempt-contexts: SUCCESS (0.311s)
[282.695005] [028/133] (744s left) gem_exec_flush (basic-uc-rw-default)
[282.743840] Starting subtest: basic-uc-rw-default
[288.226027] Subtest basic-uc-rw-default: SUCCESS (5.457s)
[288.417877] [029/133] (739s left) kms_color_pipeline (plane-lut1d)
[288.528739] Starting subtest: plane-lut1d
[288.690243] Starting dynamic subtest: pipe-A-plane-0
[288.942137] Dynamic subtest pipe-A-plane-0: FAIL (0.183s)
[288.950283] Starting dynamic subtest: pipe-A-plane-1
[289.133948] Dynamic subtest pipe-A-plane-1: FAIL (0.181s)
[289.142087] Starting dynamic subtest: pipe-A-plane-2
[289.313729] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[290.419988] Starting dynamic subtest: pipe-B-plane-0
[290.714322] Dynamic subtest pipe-B-plane-0: FAIL (0.197s)
[290.722089] Starting dynamic subtest: pipe-B-plane-1
[290.898551] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[290.906644] Starting dynamic subtest: pipe-B-plane-2
[291.054079] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[292.131686] Starting dynamic subtest: pipe-C-plane-0
[292.414448] Dynamic subtest pipe-C-plane-0: FAIL (0.164s)
[292.421726] Starting dynamic subtest: pipe-C-plane-1
[292.584437] Dynamic subtest pipe-C-plane-1: FAIL (0.164s)
[292.593303] Starting dynamic subtest: pipe-C-plane-2
[292.748905] Dynamic subtest pipe-C-plane-2: FAIL (0.155s)
[293.766242] Starting dynamic subtest: pipe-D-plane-0
[294.076951] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[294.084989] Starting dynamic subtest: pipe-D-plane-1
[294.257327] Dynamic subtest pipe-D-plane-1: FAIL (0.143s)
[294.266441] Starting dynamic subtest: pipe-D-plane-2
[294.441609] Dynamic subtest pipe-D-plane-2: FAIL (0.155s)
[294.526506] Subtest plane-lut1d: FAIL (5.984s)
[295.343209] [030/133] (732s left) gem_exec_schedule (deep)
[295.522624] Starting subtest: deep
[295.523825] Starting dynamic subtest: rcs0
[300.682324] Dynamic subtest rcs0: SKIP (5.142s)
[300.698811] Starting dynamic subtest: vcs0
[310.692014] Dynamic subtest vcs0: SUCCESS (10.006s)
[310.702727] Starting dynamic subtest: vcs1
[321.427359] Dynamic subtest vcs1: SUCCESS (10.734s)
[321.439825] Starting dynamic subtest: vecs0
[332.508133] Dynamic subtest vecs0: SUCCESS (11.078s)
[332.516467] Starting dynamic subtest: ccs0
[345.080378] Dynamic subtest ccs0: SUCCESS (12.566s)
[345.082601] Subtest deep: SUCCESS (49.531s)
[346.293534] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[346.295592] [031/133] (681s left) kms_cursor_crc (cursor-suspend)
[346.435710] Starting subtest: cursor-suspend
[346.436523] Starting dynamic subtest: pipe-A-eDP-1
[380.339041] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.962s)
[380.347518] Starting dynamic subtest: pipe-D-eDP-1
[415.320111] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.513s)
[415.320986] Subtest cursor-suspend: SUCCESS (8.478s)
[422.201897] [032/133] (611s left) perf (gen8-unprivileged-single-ctx-counters)
[422.328488] Starting subtest: gen8-unprivileged-single-ctx-counters
[422.330136] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[422.366578] [033/133] (611s left) api_intel_bb (intel-bb-blit-y)
[422.411713] Starting subtest: intel-bb-blit-y
[426.283204] Subtest intel-bb-blit-y: SUCCESS (3.815s)
[426.392412] [034/133] (607s left) prime_mmap (test_refcounting)
[426.450228] Starting subtest: test_refcounting
[426.451137] Starting dynamic subtest: test_refcounting-smem
[426.482438] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[426.483474] Subtest test_refcounting: SUCCESS (0.033s)
[426.582022] [035/133] (607s left) kms_atomic_transition (modeset-transition)
[426.664725] Starting subtest: modeset-transition
[426.665610] Starting dynamic subtest: 1x-outputs
[437.511071] Dynamic subtest 1x-outputs: SUCCESS (10.781s)
[437.514180] Subtest modeset-transition: SUCCESS (10.783s)
[438.374478] [036/133] (595s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[438.464979] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[438.465852] Starting dynamic subtest: pipe-A
[438.483541] Dynamic subtest pipe-A: SKIP (0.017s)
[438.491453] Starting dynamic subtest: pipe-B
[438.514442] Dynamic subtest pipe-B: SKIP (0.030s)
[438.523654] Starting dynamic subtest: pipe-C
[438.544953] Dynamic subtest pipe-C: SKIP (0.030s)
[438.552501] Starting dynamic subtest: pipe-D
[438.575153] Dynamic subtest pipe-D: SKIP (0.030s)
[438.576679] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.109s)
[438.667569] [037/133] (595s left) kms_frontbuffer_tracking (fbc-suspend)
[438.753950] Starting subtest: fbc-suspend
[477.348994] Subtest fbc-suspend: SUCCESS (8.238s)
[482.598712] [038/133] (555s left) gem_pxp (display-protected-crc)
[482.737887] Starting subtest: display-protected-crc
[484.466748] Subtest display-protected-crc: SUCCESS (1.705s)
[484.591229] [039/133] (553s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[484.695316] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[484.697181] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[484.792384] [040/133] (553s left) gem_userptr_blits (dmabuf-unsync)
[484.861531] Subtest dmabuf-unsync: SKIP (0.000s)
[484.984364] [041/133] (552s left) gem_eio (context-create)
[485.199560] Starting subtest: context-create
[485.529352] Subtest context-create: SUCCESS (0.326s)
[485.663681] [042/133] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[485.760173] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[492.720224] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.911s)
[492.862835] [043/133] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[492.966023] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[492.967860] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[493.052907] [044/133] (545s left) kms_selftest (drm_dp_mst_helper)
[493.083985] Starting subtest: drm_dp_mst_helper
[493.124754] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[493.284469] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.152s)
[493.294449] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[493.385527] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.108s)
[493.395036] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[493.488382] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.101s)
[493.489374] Subtest drm_dp_mst_helper: SUCCESS (0.403s)
[493.635066] [045/133] (544s left) gem_spin_batch (resubmit-new)
[493.696853] Starting subtest: resubmit-new
[493.697756] Starting dynamic subtest: rcs0
[493.704387] Dynamic subtest rcs0: SUCCESS (0.009s)
[493.712627] Starting dynamic subtest: bcs0
[493.713502] Dynamic subtest bcs0: SUCCESS (0.004s)
[493.721156] Starting dynamic subtest: vcs0
[493.722019] Dynamic subtest vcs0: SUCCESS (0.004s)
[493.729913] Starting dynamic subtest: vcs1
[493.730793] Dynamic subtest vcs1: SUCCESS (0.004s)
[493.738576] Starting dynamic subtest: vecs0
[493.739522] Dynamic subtest vecs0: SUCCESS (0.004s)
[493.747331] Starting dynamic subtest: ccs0
[493.748202] Dynamic subtest ccs0: SUCCESS (0.005s)
[493.749129] Subtest resubmit-new: SUCCESS (0.036s)
[495.378466] [046/133] (542s left) testdisplay
[495.673531] [047/133] (542s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[495.758004] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[495.758905] Starting dynamic subtest: pipe-A-eDP-1
[495.881102] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[495.889999] Starting dynamic subtest: pipe-B-eDP-1
[497.070359] Dynamic subtest pipe-B-eDP-1: SKIP (1.184s)
[497.072138] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.309s)
[498.277380] [048/133] (539s left) i915_selftest (live)
[500.086586] Starting subtest: live
[500.087789] Starting dynamic subtest: sanitycheck
[504.424051] Dynamic subtest sanitycheck: SUCCESS (4.330s)
[504.433250] Starting dynamic subtest: uncore
[508.789118] Dynamic subtest uncore: SUCCESS (4.360s)
[508.797972] Starting dynamic subtest: workarounds
[511.860963] Dynamic subtest workarounds: SUCCESS (3.068s)
[511.869178] Starting dynamic subtest: gt_engines
[514.965915] Dynamic subtest gt_engines: SUCCESS (3.106s)
[514.974960] Starting dynamic subtest: gt_timelines
[531.096397] Dynamic subtest gt_timelines: SUCCESS (16.132s)
[531.106152] Starting dynamic subtest: gt_contexts
[535.449628] Dynamic subtest gt_contexts: SUCCESS (4.351s)
[535.458940] Starting dynamic subtest: gt_lrc
[539.821911] Dynamic subtest gt_lrc: SUCCESS (4.370s)
[539.832648] Starting dynamic subtest: gt_mocs
[542.807079] Dynamic subtest gt_mocs: SUCCESS (2.981s)
[542.818266] Starting dynamic subtest: gt_pm
[547.552105] Dynamic subtest gt_pm: SUCCESS (4.742s)
[547.561900] Starting dynamic subtest: gt_heartbeat
[551.897065] Dynamic subtest gt_heartbeat: SUCCESS (4.343s)
[551.904745] Starting dynamic subtest: gt_tlb
[561.684683] Dynamic subtest gt_tlb: SUCCESS (9.781s)
[561.693687] Starting dynamic subtest: requests
[573.570593] Dynamic subtest requests: SUCCESS (11.881s)
[573.577241] Starting dynamic subtest: migrate
[579.259707] Dynamic subtest migrate: SUCCESS (5.687s)
[579.268177] Starting dynamic subtest: active
[583.660356] Dynamic subtest active: SUCCESS (4.400s)
[583.669874] Starting dynamic subtest: objects
[587.017163] Dynamic subtest objects: SUCCESS (3.355s)
[587.025908] Starting dynamic subtest: mman
[591.820737] Dynamic subtest mman: SUCCESS (4.803s)
[591.830101] Starting dynamic subtest: dmabuf
[596.138079] Dynamic subtest dmabuf: SUCCESS (4.318s)
[596.148441] Starting dynamic subtest: vma
[600.470974] Dynamic subtest vma: SUCCESS (4.331s)
[600.477077] Starting dynamic subtest: coherency
[605.384936] Dynamic subtest coherency: SUCCESS (4.913s)
[605.394019] Starting dynamic subtest: gtt
[617.545698] Dynamic subtest gtt: SUCCESS (12.158s)
[617.554499] Starting dynamic subtest: gem
[624.985251] Dynamic subtest gem: SUCCESS (7.437s)
[624.993842] Starting dynamic subtest: evict
[630.550782] Dynamic subtest evict: SUCCESS (5.562s)
[630.557085] Starting dynamic subtest: hugepages
[639.823175] Dynamic subtest hugepages: SUCCESS (9.269s)
[639.831465] Starting dynamic subtest: gem_contexts
[667.385461] Dynamic subtest gem_contexts: SUCCESS (27.556s)
[667.394653] Starting dynamic subtest: client
[671.815010] Dynamic subtest client: SUCCESS (4.428s)
[671.824109] Starting dynamic subtest: gem_migrate
[676.125435] Dynamic subtest gem_migrate: SUCCESS (4.308s)
[676.134215] Starting dynamic subtest: reset
[679.054153] Dynamic subtest reset: SUCCESS (2.926s)
[679.061564] Starting dynamic subtest: memory_region
[681.808271] Dynamic subtest memory_region: SUCCESS (2.751s)
[681.817199] Starting dynamic subtest: hangcheck
[695.318025] Dynamic subtest hangcheck: SUCCESS (13.505s)
[695.325433] Starting dynamic subtest: execlists
[698.017647] Dynamic subtest execlists: SUCCESS (2.697s)
[698.026497] Starting dynamic subtest: ring_submission
[700.724857] Dynamic subtest ring_submission: SUCCESS (2.706s)
[700.736076] Starting dynamic subtest: perf
[705.083576] Dynamic subtest perf: SUCCESS (4.355s)
[705.092174] Starting dynamic subtest: slpc
[719.632892] Dynamic subtest slpc: SUCCESS (14.550s)
[719.641272] Starting dynamic subtest: guc
[723.550053] Dynamic subtest guc: SUCCESS (3.915s)
[723.559578] Starting dynamic subtest: guc_multi_lrc
[727.906279] Dynamic subtest guc_multi_lrc: SUCCESS (4.356s)
[727.915257] Starting dynamic subtest: guc_hang
[732.689690] Dynamic subtest guc_hang: SUCCESS (4.782s)
[732.698477] Starting dynamic subtest: late_gt_pm
[737.052534] Dynamic subtest late_gt_pm: SUCCESS (4.361s)
[737.053983] Subtest live: SUCCESS (236.939s)
[737.075955] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[737.076699] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[737.078444] [049/133] (301s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[738.649730] Subtest writes-after-reads-uncached: SKIP (0.000s)
[738.732019] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[738.733339] [FACT gem_partial_pwrite_pread (writes-after-reads-uncached)] new: kernel.kmod_is_loaded.i915: true
[738.736401] [050/133] (299s left) kms_getfb (getfb-handle-not-fb)
[738.825841] Starting subtest: getfb-handle-not-fb
[738.827119] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[738.921408] [051/133] (299s left) kms_psr (fbc-psr-sprite-plane-onoff)
[739.029748] Starting subtest: fbc-psr-sprite-plane-onoff
[739.030633] Starting dynamic subtest: eDP-1
[739.032254] Dynamic subtest eDP-1: SKIP (0.000s)
[739.034112] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[739.095799] [052/133] (299s left) i915_hangman (gt-error-state-capture)
[739.168742] Starting subtest: gt-error-state-capture
[739.169636] Starting dynamic subtest: rcs0
[749.324873] Dynamic subtest rcs0: SUCCESS (10.157s)
[749.334192] Starting dynamic subtest: bcs0
[761.370031] Dynamic subtest bcs0: SUCCESS (12.032s)
[761.380118] Starting dynamic subtest: vcs0
[772.310603] Dynamic subtest vcs0: SUCCESS (10.938s)
[772.320598] Starting dynamic subtest: vcs1
[784.278430] Dynamic subtest vcs1: SUCCESS (11.964s)
[784.286001] Starting dynamic subtest: vecs0
[794.262473] Dynamic subtest vecs0: SUCCESS (9.980s)
[794.272953] Starting dynamic subtest: ccs0
[805.334972] Dynamic subtest ccs0: SUCCESS (11.069s)
[805.336180] Subtest gt-error-state-capture: SUCCESS (66.156s)
[805.444689] [053/133] (232s left) perf (invalid-open-flags)
[805.582814] Starting subtest: invalid-open-flags
[805.583651] Subtest invalid-open-flags: SUCCESS (0.000s)
[805.622579] [054/133] (232s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[805.715751] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[805.717630] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[805.809415] [055/133] (232s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[805.892585] Starting subtest: async-flip-with-page-flip-events-linear
[806.280753] Starting dynamic subtest: pipe-A-eDP-1
[809.085526] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.794s)
[809.445432] Starting dynamic subtest: pipe-B-eDP-1
[812.207221] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[812.559796] Starting dynamic subtest: pipe-C-eDP-1
[815.334217] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.770s)
[815.684057] Starting dynamic subtest: pipe-D-eDP-1
[818.463005] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[818.464591] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.561s)
[819.634510] [056/133] (218s left) sw_sync (alloc_fence)
[819.663913] Starting subtest: alloc_fence
[819.664824] Subtest alloc_fence: SUCCESS (0.000s)
[819.720354] [057/133] (218s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[819.806654] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[819.807505] Starting dynamic subtest: pipe-A-default-mode
[821.000610] Dynamic subtest pipe-A-default-mode: SKIP (1.191s)
[821.002213] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.193s)
[821.149501] [058/133] (217s left) gem_ctx_persistence (heartbeat-close)
[821.216449] Starting subtest: heartbeat-close
[821.218078] Subtest heartbeat-close: SKIP (0.000s)
[821.314455] [059/133] (217s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[821.415558] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[821.417482] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[821.510022] [060/133] (217s left) kms_flip (2x-flip-vs-modeset)
[821.603714] Starting subtest: 2x-flip-vs-modeset
[821.613944] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[821.691475] [061/133] (216s left) sw_sync (alloc_timeline)
[821.721333] Starting subtest: alloc_timeline
[821.722186] Subtest alloc_timeline: SUCCESS (0.000s)
[821.767660] [062/133] (216s left) gem_exec_fence (syncobj-timeline-chain-engines)
[822.316380] Starting subtest: syncobj-timeline-chain-engines
[822.439957] Subtest syncobj-timeline-chain-engines: SUCCESS (0.124s)
[823.421022] [063/133] (215s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[823.510841] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[823.512757] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[823.579080] [064/133] (215s left) perf_pmu (all-busy-check-all)
[823.624865] Starting subtest: all-busy-check-all
[825.335802] Subtest all-busy-check-all: SUCCESS (1.702s)
[825.415642] [065/133] (213s left) kms_chamelium_frames (hdmi-crc-single)
[825.810371] Subtest hdmi-crc-single: SKIP (0.000s)
[826.579899] [066/133] (212s left) kms_draw_crc (draw-method-mmap-wc)
[826.674541] Starting subtest: draw-method-mmap-wc
[826.675493] Starting dynamic subtest: xrgb8888-untiled
[826.918175] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[826.926834] Starting dynamic subtest: rgb565-untiled
[827.140487] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[827.154921] Starting dynamic subtest: xrgb2101010-untiled
[827.363180] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[827.379664] Starting dynamic subtest: xbgr16161616f-untiled
[827.596025] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.231s)
[827.606130] Starting dynamic subtest: xrgb8888-xtiled
[827.729208] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[827.738540] Starting dynamic subtest: rgb565-xtiled
[827.873828] Dynamic subtest rgb565-xtiled: SUCCESS (0.142s)
[827.881921] Starting dynamic subtest: xrgb2101010-xtiled
[827.995990] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[828.005455] Starting dynamic subtest: xbgr16161616f-xtiled
[828.129461] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[828.137696] Starting dynamic subtest: xrgb8888-4tiled
[828.296409] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[828.307805] Starting dynamic subtest: rgb565-4tiled
[828.462915] Dynamic subtest rgb565-4tiled: SUCCESS (0.163s)
[828.471318] Starting dynamic subtest: xrgb2101010-4tiled
[828.618510] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s)
[828.631138] Starting dynamic subtest: xbgr16161616f-4tiled
[828.796382] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[828.798451] Subtest draw-method-mmap-wc: SUCCESS (2.124s)
[828.899017] [067/133] (209s left) kms_content_protection (atomic)
[829.040357] Starting subtest: atomic
[829.042566] Subtest atomic: SKIP (0.000s)
[829.148048] [068/133] (209s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[829.243899] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[829.244814] Starting dynamic subtest: pipe-A-eDP-1
[829.253325] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[829.266655] Starting dynamic subtest: pipe-B-eDP-1
[829.276743] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[829.287534] Starting dynamic subtest: pipe-C-eDP-1
[829.295939] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[829.303945] Starting dynamic subtest: pipe-D-eDP-1
[829.312125] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[829.313799] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[831.479987] [069/133] (207s left) kms_psr (pr-primary-render)
[831.560734] Starting subtest: pr-primary-render
[831.562311] Subtest pr-primary-render: SKIP (0.000s)
[831.641508] [070/133] (207s left) gem_exec_flush (basic-uc-ro-default)
[831.696835] Starting subtest: basic-uc-ro-default
[837.154539] Subtest basic-uc-ro-default: SUCCESS (5.457s)
[837.335239] [071/133] (201s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[837.419134] Starting subtest: fb-8bpc-vs-panel-8bpc
[837.419867] Starting dynamic subtest: pipe-A-eDP-1
[838.804356] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.383s)
[838.805316] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.384s)
[839.661412] [072/133] (199s left) gem_madvise (dontneed-after-mmap)
[839.692542] Starting subtest: dontneed-after-mmap
[839.717481] Subtest dontneed-after-mmap: SUCCESS (0.025s)
[839.821495] [073/133] (199s left) kms_plane_alpha_blend (constant-alpha-mid)
[839.907838] Starting subtest: constant-alpha-mid
[840.199848] Starting dynamic subtest: pipe-A-eDP-1
[841.121175] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.921s)
[841.130936] Starting dynamic subtest: pipe-D-eDP-1
[842.664018] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.541s)
[842.665123] Subtest constant-alpha-mid: SUCCESS (2.756s)
[843.538806] [074/133] (195s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[843.587944] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[843.643527] [075/133] (195s left) kms_flip (2x-flip-vs-wf_vblank)
[843.736455] Starting subtest: 2x-flip-vs-wf_vblank
[843.747362] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[843.826292] [076/133] (195s left) kms_cursor_crc (cursor-sliding-128x42)
[844.062977] Starting subtest: cursor-sliding-128x42
[844.115504] Subtest cursor-sliding-128x42: SKIP (0.051s)
[844.302008] [077/133] (194s left) kms_psr (psr2-suspend)
[844.386372] Starting subtest: psr2-suspend
[844.387195] Starting dynamic subtest: eDP-1
[862.257805] Dynamic subtest eDP-1: SUCCESS (3.558s)
[862.258963] Subtest psr2-suspend: SUCCESS (3.559s)
[872.110418] [078/133] (176s left) gem_mmap_offset (open-flood)
[872.159874] Starting subtest: open-flood
[893.626528] Subtest open-flood: SUCCESS (21.494s)
[893.726455] [079/133] (154s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[893.822056] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[893.823736] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[893.906605] [080/133] (154s left) gem_exec_nop (basic-sequential)
[893.969661] Starting subtest: basic-sequential
[909.147983] Subtest basic-sequential: SUCCESS (15.182s)
[909.365666] [081/133] (139s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[909.462959] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[909.465209] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[909.539541] [082/133] (138s left) gem_mmap_gtt (basic-small-bo-tiledy)
[909.586756] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[909.640446] [083/133] (138s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[909.727404] Starting subtest: y-tiled-64bpp-rotate-90
[909.729262] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[909.820990] [084/133] (138s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[909.910084] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[919.003864] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (9.095s)
[919.110814] [085/133] (129s left) gem_exec_alignment (single)
[919.162810] Starting subtest: single
[919.166488] Subtest single: SUCCESS (0.004s)
[919.283783] [086/133] (129s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[919.385008] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[919.387414] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[919.468710] [087/133] (129s left) syncobj_timeline (etime-single-wait-submitted)
[919.517089] Starting subtest: etime-single-wait-submitted
[919.619156] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[919.702758] [088/133] (128s left) i915_drm_fdinfo (virtual-busy-all)
[919.742159] Starting subtest: virtual-busy-all
[919.744573] Subtest virtual-busy-all: SKIP (0.000s)
[919.800460] [089/133] (128s left) gem_ctx_exec (basic)
[919.854513] Starting subtest: basic
[919.861549] Subtest basic: SUCCESS (0.007s)
[919.975435] [090/133] (128s left) gem_busy (parallel)
[920.162719] Starting subtest: parallel
[920.164328] Starting dynamic subtest: rcs0
[921.696136] Dynamic subtest rcs0: SUCCESS (1.528s)
[921.708547] Starting dynamic subtest: bcs0
[923.681786] Dynamic subtest bcs0: SUCCESS (1.983s)
[923.693427] Starting dynamic subtest: vcs0
[925.665860] Dynamic subtest vcs0: SUCCESS (1.982s)
[925.677695] Starting dynamic subtest: vcs1
[927.649501] Dynamic subtest vcs1: SUCCESS (1.982s)
[927.660841] Starting dynamic subtest: vecs0
[929.696132] Dynamic subtest vecs0: SUCCESS (2.045s)
[929.707677] Starting dynamic subtest: ccs0
[931.680861] Dynamic subtest ccs0: SUCCESS (1.982s)
[931.682144] Subtest parallel: SUCCESS (11.515s)
[931.919175] [091/133] (116s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[931.977561] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[931.978856] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[932.072805] [092/133] (116s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[932.170995] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[932.173603] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[932.243310] [093/133] (116s left) kms_vblank (ts-continuation-dpms-rpm)
[932.329774] Starting subtest: ts-continuation-dpms-rpm
[932.330791] Starting dynamic subtest: pipe-A-eDP-1
[934.904509] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.574s)
[934.914839] Starting dynamic subtest: pipe-D-eDP-1
[937.159448] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.251s)
[937.160368] Subtest ts-continuation-dpms-rpm: SUCCESS (4.830s)
[937.953030] [094/133] (110s left) sw_sync (timeline_closed_signaled)
[937.993265] Starting subtest: timeline_closed_signaled
[937.994739] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[938.055364] [095/133] (110s left) gem_lmem_swapping (verify)
[938.098338] Subtest verify: SKIP (0.000s)
[938.139675] [096/133] (110s left) syncobj_wait (invalid-signal-zero-handles)
[938.192576] Starting subtest: invalid-signal-zero-handles
[938.193811] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[938.282913] [097/133] (110s left) kms_pm_rpm (i2c)
[939.809487] Starting subtest: i2c
[945.126854] Subtest i2c: SUCCESS (5.320s)
[945.244120] [098/133] (103s left) vgem_basic (setversion)
[945.290910] Starting subtest: setversion
[945.293593] Subtest setversion: SUCCESS (0.000s)
[945.356524] [099/133] (103s left) gem_exec_reloc (basic-write-gtt)
[945.413882] Subtest basic-write-gtt: SKIP (0.000s)
[945.476044] [100/133] (103s left) kms_scaling_modes (scaling-mode-center)
[945.566529] Starting subtest: scaling-mode-center
[945.567683] Starting dynamic subtest: pipe-A-eDP-1
[945.663483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[945.673898] Starting dynamic subtest: pipe-B-eDP-1
[946.827686] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.163s)
[946.839174] Starting dynamic subtest: pipe-C-eDP-1
[947.937371] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s)
[947.948866] Starting dynamic subtest: pipe-D-eDP-1
[949.071624] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[949.072586] Subtest scaling-mode-center: SUCCESS (3.508s)
[950.237799] [101/133] ( 98s left) perf_pmu (frequency)
[950.273607] Starting subtest: frequency
[950.277470] Starting dynamic subtest: gt0
[952.387539] Dynamic subtest gt0: SUCCESS (2.107s)
[952.398965] Starting dynamic subtest: idle-gt0
[952.901678] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[952.912979] Starting dynamic subtest: gt1
[957.660905] Dynamic subtest gt1: SUCCESS (4.756s)
[957.673025] Starting dynamic subtest: idle-gt1
[958.164873] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[958.166154] Subtest frequency: SUCCESS (7.888s)
[958.248325] [102/133] ( 90s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[958.358465] Starting subtest: 4-tiled-32bpp-rotate-180
[959.782132] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.424s)
[959.914543] [103/133] ( 89s left) kms_hdr (bpc-switch-dpms)
[960.009466] Starting subtest: bpc-switch-dpms
[961.099885] Starting dynamic subtest: pipe-A-eDP-1
[965.617210] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.519s)
[965.618016] Subtest bpc-switch-dpms: SUCCESS (5.610s)
[965.738317] [104/133] ( 83s left) syncobj_timeline (wait-any-interrupted)
[965.785148] Starting subtest: wait-any-interrupted
[965.891188] Subtest wait-any-interrupted: SUCCESS (0.105s)
[965.964954] [105/133] ( 83s left) gem_exec_parallel (contexts)
[966.027465] Starting subtest: contexts
[966.028752] Starting dynamic subtest: rcs0
[969.423921] Dynamic subtest rcs0: SUCCESS (3.389s)
[969.433423] Starting dynamic subtest: bcs0
[973.548161] Dynamic subtest bcs0: SUCCESS (4.120s)
[973.567986] Starting dynamic subtest: vcs0
[978.160753] Dynamic subtest vcs0: SUCCESS (4.610s)
[978.176646] Starting dynamic subtest: vcs1
[983.984768] Dynamic subtest vcs1: SUCCESS (5.820s)
[983.996960] Starting dynamic subtest: vecs0
[990.084723] Dynamic subtest vecs0: SUCCESS (6.060s)
[990.096169] Starting dynamic subtest: ccs0
[994.622065] Dynamic subtest ccs0: SUCCESS (4.571s)
[994.623779] Subtest contexts: SUCCESS (28.585s)
[994.818881] [106/133] ( 54s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[994.937499] Starting subtest: verify-pxp-key-change-after-suspend-resume
[1002.127188] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.191s)
[1010.286532] [107/133] ( 47s left) gem_create (create-ext-placement-each)
[1010.453729] Starting subtest: create-ext-placement-each
[1010.454975] Subtest create-ext-placement-each: SUCCESS (0.000s)
[1010.546566] [108/133] ( 46s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[1010.635421] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[1010.636400] Starting dynamic subtest: pipe-A-eDP-1
[1010.643813] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[1010.653343] Starting dynamic subtest: pipe-B-eDP-1
[1010.661390] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[1010.670037] Starting dynamic subtest: pipe-C-eDP-1
[1010.677961] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[1010.686485] Starting dynamic subtest: pipe-D-eDP-1
[1010.693021] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[1010.693741] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[1012.879774] [109/133] ( 44s left) gem_close_race (basic-process)
[1012.947494] Starting subtest: basic-process
[1012.999428] Subtest basic-process: SUCCESS (0.052s)
[1013.178233] [110/133] ( 44s left) gem_exec_schedule (u-independent)
[1013.236779] Starting subtest: u-independent
[1013.238507] Starting dynamic subtest: rcs0
[1014.678599] Dynamic subtest rcs0: SUCCESS (1.443s)
[1014.692170] Starting dynamic subtest: vcs0
[1016.677755] Dynamic subtest vcs0: SUCCESS (1.996s)
[1016.687886] Starting dynamic subtest: vcs1
[1018.668863] Dynamic subtest vcs1: SUCCESS (1.979s)
[1018.681676] Starting dynamic subtest: vecs0
[1020.714892] Dynamic subtest vecs0: SUCCESS (2.043s)
[1020.725581] Starting dynamic subtest: ccs0
[1022.688197] Dynamic subtest ccs0: SUCCESS (1.971s)
[1022.689900] Subtest u-independent: SUCCESS (9.445s)
[1022.992199] [111/133] ( 34s left) gen9_exec_parse (batch-without-end)
[1023.059540] Subtest batch-without-end: SKIP (0.000s)
[1023.125495] [112/133] ( 34s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[1024.849165] Starting subtest: dpms-mode-unset-lpsp
[1028.914136] Subtest dpms-mode-unset-lpsp: SUCCESS (4.067s)
[1029.296762] [113/133] ( 28s left) kms_chamelium_hpd (vga-hpd)
[1029.676010] Subtest vga-hpd: SKIP (0.000s)
[1030.490798] [114/133] ( 27s left) gem_lmem_swapping (heavy-multi)
[1030.527542] Subtest heavy-multi: SKIP (0.000s)
[1030.574774] [115/133] ( 27s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[1030.671613] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[1030.673433] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[1030.738335] [116/133] ( 27s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[1030.829215] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[1030.831378] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[1030.921405] [117/133] ( 26s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[1031.009275] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[1035.595507] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.587s)
[1036.713534] [118/133] ( 21s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[1036.810047] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[1044.192135] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.384s)
[1044.315482] [119/133] ( 13s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[1044.410358] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[1044.411891] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[1044.504248] [120/133] ( 13s left) gem_exec_balancer (noheartbeat)
[1044.770440] Starting subtest: noheartbeat
[1044.772909] Subtest noheartbeat: SKIP (0.000s)
[1044.860512] [121/133] ( 13s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[1044.904810] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[1045.010699] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[1045.084351] [122/133] ( 12s left) kms_big_fb (linear-addfb)
[1045.174448] Starting subtest: linear-addfb
[1045.175762] Subtest linear-addfb: SUCCESS (0.000s)
[1045.266643] [123/133] ( 12s left) perf_pmu (busy)
[1045.302847] Starting subtest: busy
[1045.303977] Starting dynamic subtest: rcs0
[1045.887936] Dynamic subtest rcs0: SUCCESS (0.584s)
[1045.901736] Starting dynamic subtest: bcs0
[1046.457793] Dynamic subtest bcs0: SUCCESS (0.567s)
[1046.474860] Starting dynamic subtest: vcs0
[1047.702490] Dynamic subtest vcs0: SUCCESS (1.242s)
[1047.716727] Starting dynamic subtest: vcs1
[1049.695977] Dynamic subtest vcs1: SUCCESS (1.981s)
[1049.708528] Starting dynamic subtest: vecs0
[1051.679960] Dynamic subtest vecs0: SUCCESS (1.981s)
[1051.692275] Starting dynamic subtest: ccs0
[1052.239568] Dynamic subtest ccs0: SUCCESS (0.566s)
[1052.241140] Subtest busy: SUCCESS (6.938s)
[1052.330955] [124/133] (  5s left) kms_force_connector_basic (force-load-detect)
[1052.411064] Starting subtest: force-load-detect
[1052.413689] Subtest force-load-detect: SKIP (0.000s)
[1052.534817] [125/133] (  5s left) gem_ctx_param (invalid-get-ringsize)
[1052.585944] Starting subtest: invalid-get-ringsize
[1052.587702] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[1052.691102] [126/133] (  5s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[1052.781564] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[1060.153612] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.373s)
[1060.245308] Overall timeout time exceeded, stopping.
[1060.262596] 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.